builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0314 starttime: 1465288798.24 results: success (0) buildid: 20160606194329 builduid: 3d31ab4f42854c829e06ac6160cc676b revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:39:58.239002) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:39:58.239508) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:39:58.239819) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:39:58.265144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:39:58.265575) ========= 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.ntq17foTAs/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.ohcJ90Op8u/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-07 01:39:58-- 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-06-07 01:39:58 (57.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:39:58.404849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:39:58.405161) ========= 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.ntq17foTAs/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.ohcJ90Op8u/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.026112 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:39:58.454428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 01:39:58.454800) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ntq17foTAs/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.ohcJ90Op8u/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-07 01:39:58,539 truncating revision to first 12 chars 2016-06-07 01:39:58,540 Setting DEBUG logging. 2016-06-07 01:39:58,540 attempt 1/10 2016-06-07 01:39:58,540 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1f9f6bdee31c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 01:40:00,229 unpacking tar archive at: mozilla-beta-1f9f6bdee31c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.950682 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 01:40:00.426366) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:40:00.426710) ========= script_repo_revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:40:00.427097) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:40:00.427363) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:40:00.444808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-07 01:40:00.445145) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ntq17foTAs/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.ohcJ90Op8u/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:40:00 INFO - MultiFileLogger online at 20160607 01:40:00 in /builds/slave/test 01:40:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:40:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:40:00 INFO - {'append_to_log': False, 01:40:00 INFO - 'base_work_dir': '/builds/slave/test', 01:40:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:40:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:40:00 INFO - 'branch': 'Mozilla-Beta', 01:40:00 INFO - 'buildbot_json_path': 'buildprops.json', 01:40:00 INFO - 'config_files': ('talos/mac_config.py',), 01:40:00 INFO - 'default_actions': ('clobber', 01:40:00 INFO - 'read-buildbot-config', 01:40:00 INFO - 'download-and-extract', 01:40:00 INFO - 'populate-webroot', 01:40:00 INFO - 'create-virtualenv', 01:40:00 INFO - 'install', 01:40:00 INFO - 'run-tests'), 01:40:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:40:00 INFO - 'download_minidump_stackwalk': True, 01:40:00 INFO - 'download_symbols': 'ondemand', 01:40:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:40:00 INFO - 'tooltool.py': '/tools/tooltool.py', 01:40:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:40:00 INFO - '/tools/misc-python/virtualenv.py')}, 01:40:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:40:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:40:00 INFO - 'installer_path': 'installer.exe', 01:40:00 INFO - 'log_level': 'info', 01:40:00 INFO - 'log_name': 'talos', 01:40:00 INFO - 'log_to_console': True, 01:40:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:40:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:40:00 INFO - 'opt_config_files': (), 01:40:00 INFO - 'pip_index': False, 01:40:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:40:00 INFO - 'cmd': ('bash', 01:40:00 INFO - '-c', 01:40:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:40:00 INFO - 'enabled': True, 01:40:00 INFO - 'halt_on_failure': False, 01:40:00 INFO - 'name': 'check_screen_resolution'},), 01:40:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:40:00 INFO - 'cmd': ('bash', 01:40:00 INFO - '-c', 01:40:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:40:00 INFO - 'enabled': True, 01:40:00 INFO - 'halt_on_failure': False, 01:40:00 INFO - 'name': 'check_screen_resolution'},), 01:40:00 INFO - 'run_cmd_checks_enabled': True, 01:40:00 INFO - 'sps_profile': False, 01:40:00 INFO - 'sps_profile_interval': 0, 01:40:00 INFO - 'suite': 'dromaeojs', 01:40:00 INFO - 'system_bits': '32', 01:40:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:40:00 INFO - 'title': 't-yosemite-r7-0314', 01:40:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:40:00 INFO - 'use_talos_json': True, 01:40:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:40:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:40:00 INFO - 'work_dir': 'build'} 01:40:00 INFO - ##### 01:40:00 INFO - ##### Running clobber step. 01:40:00 INFO - ##### 01:40:00 INFO - Running pre-action listener: _resource_record_pre_action 01:40:00 INFO - Running main action method: clobber 01:40:00 INFO - rmtree: /builds/slave/test/build 01:40:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:40:02 INFO - Running post-action listener: _resource_record_post_action 01:40:02 INFO - ##### 01:40:02 INFO - ##### Running read-buildbot-config step. 01:40:02 INFO - ##### 01:40:02 INFO - Running pre-action listener: _resource_record_pre_action 01:40:02 INFO - Running main action method: read_buildbot_config 01:40:02 INFO - Using buildbot properties: 01:40:02 INFO - { 01:40:02 INFO - "project": "", 01:40:02 INFO - "product": "firefox", 01:40:02 INFO - "script_repo_revision": "production", 01:40:02 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 01:40:02 INFO - "repository": "", 01:40:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 01:40:02 INFO - "buildid": "20160606194329", 01:40:02 INFO - "pgo_build": "False", 01:40:02 INFO - "basedir": "/builds/slave/test", 01:40:02 INFO - "buildnumber": 0, 01:40:02 INFO - "slavename": "t-yosemite-r7-0314", 01:40:02 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 01:40:02 INFO - "platform": "yosemite_r7", 01:40:02 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:40:02 INFO - "branch": "mozilla-beta", 01:40:02 INFO - "repo_path": "releases/mozilla-beta", 01:40:02 INFO - "revision": "1f9f6bdee31c14fd5a39485e8ae326de2928ef7d", 01:40:02 INFO - "stage_platform": "macosx64", 01:40:02 INFO - "builduid": "3d31ab4f42854c829e06ac6160cc676b", 01:40:02 INFO - "slavebuilddir": "test" 01:40:02 INFO - } 01:40:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 01:40:02 INFO - Running post-action listener: _resource_record_post_action 01:40:02 INFO - ##### 01:40:02 INFO - ##### Running download-and-extract step. 01:40:02 INFO - ##### 01:40:02 INFO - Running pre-action listener: _resource_record_pre_action 01:40:02 INFO - Running main action method: download_and_extract 01:40:02 INFO - mkdir: /builds/slave/test/build/tests 01:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:02 INFO - https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:40:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:40:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:40:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 01:40:07 INFO - Downloaded 1165 bytes. 01:40:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:40:07 INFO - Using the following test package requirements: 01:40:07 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:40:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:40:07 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:40:07 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:40:07 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:40:07 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:40:07 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:40:07 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:40:07 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:40:07 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:40:07 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:40:07 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:40:07 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:40:07 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:40:07 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:40:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:40:07 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:40:07 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:07 INFO - https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:40:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:40:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:40:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:40:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:40:08 INFO - Downloaded 18292404 bytes. 01:40:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:40:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:40:11 INFO - Return code: 0 01:40:11 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 01:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:11 INFO - https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:40:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:40:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:40:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:40:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:40:13 INFO - Downloaded 18292404 bytes. 01:40:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:40:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:40:16 INFO - Return code: 0 01:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:16 INFO - https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:40:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:40:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:40:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 01:40:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 01:40:17 INFO - Downloaded 10840145 bytes. 01:40:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:40:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:40:18 INFO - Return code: 0 01:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:18 INFO - https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:40:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:40:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:40:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:40:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 01:40:20 INFO - Downloaded 86247433 bytes. 01:40:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:40:20 INFO - mkdir: /builds/slave/test/properties 01:40:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:40:20 INFO - Writing to file /builds/slave/test/properties/build_url 01:40:20 INFO - Contents: 01:40:20 INFO - build_url:https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:40:22 INFO - Running post-action listener: _resource_record_post_action 01:40:22 INFO - Running post-action listener: set_extra_try_arguments 01:40:22 INFO - ##### 01:40:22 INFO - ##### Running populate-webroot step. 01:40:22 INFO - ##### 01:40:22 INFO - Running pre-action listener: _resource_record_pre_action 01:40:22 INFO - Running main action method: populate_webroot 01:40:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:40:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:40:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:40:22 INFO - '--tppagecycles', 01:40:22 INFO - '7'], 01:40:22 INFO - 'tests': ['tsvgm']}}, 01:40:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:40:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:40:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:40:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:40:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:40:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:40:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:22 INFO - 'talos_options': ['--disable-e10s'], 01:40:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:22 INFO - 'talos_options': ['--disable-e10s'], 01:40:22 INFO - 'tests': ['damp', 'tps']}, 01:40:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:22 INFO - 'tests': ['damp', 'tps']}, 01:40:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:40:22 INFO - 'tests': ['dromaeo_dom']}, 01:40:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:40:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:40:22 INFO - 'tests': ['a11yr', 01:40:22 INFO - 'ts_paint', 01:40:22 INFO - 'tpaint', 01:40:22 INFO - 'sessionrestore', 01:40:22 INFO - 'sessionrestore_no_auto_restore', 01:40:22 INFO - 'tabpaint']}, 01:40:22 INFO - 'other-e10s': {'tests': ['a11yr', 01:40:22 INFO - 'ts_paint', 01:40:22 INFO - 'tpaint', 01:40:22 INFO - 'sessionrestore', 01:40:22 INFO - 'sessionrestore_no_auto_restore', 01:40:22 INFO - 'tabpaint']}, 01:40:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:40:22 INFO - 'ts_paint', 01:40:22 INFO - 'tpaint', 01:40:22 INFO - 'sessionrestore', 01:40:22 INFO - 'sessionrestore_no_auto_restore', 01:40:22 INFO - 'tabpaint']}, 01:40:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:40:22 INFO - 'ts_paint', 01:40:22 INFO - 'tpaint', 01:40:22 INFO - 'sessionrestore', 01:40:22 INFO - 'sessionrestore_no_auto_restore', 01:40:22 INFO - 'tabpaint']}, 01:40:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:40:22 INFO - 'tests': ['a11yr', 01:40:22 INFO - 'ts_paint', 01:40:22 INFO - 'tpaint', 01:40:22 INFO - 'sessionrestore', 01:40:22 INFO - 'sessionrestore_no_auto_restore', 01:40:22 INFO - 'tabpaint']}, 01:40:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:40:22 INFO - 'tests': ['a11yr', 01:40:22 INFO - 'ts_paint', 01:40:22 INFO - 'tpaint', 01:40:22 INFO - 'sessionrestore', 01:40:22 INFO - 'sessionrestore_no_auto_restore', 01:40:22 INFO - 'tabpaint']}, 01:40:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:40:22 INFO - 'tests': ['tsvgx', 01:40:22 INFO - 'tsvgr_opacity', 01:40:22 INFO - 'tart', 01:40:22 INFO - 'tscrollx', 01:40:22 INFO - 'cart']}, 01:40:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:40:22 INFO - 'tsvgr_opacity', 01:40:22 INFO - 'tart', 01:40:22 INFO - 'tscrollx', 01:40:22 INFO - 'cart']}, 01:40:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:22 INFO - 'talos_options': ['--disable-e10s'], 01:40:22 INFO - 'tests': ['tp5o']}, 01:40:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:22 INFO - 'tests': ['tp5o']}, 01:40:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:22 INFO - 'talos_options': ['--disable-e10s', 01:40:22 INFO - '--xperf_path', 01:40:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:22 INFO - 'tests': ['tp5n']}, 01:40:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:22 INFO - 'talos_options': ['--xperf_path', 01:40:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:22 INFO - 'tests': ['tp5n']}}, 01:40:22 INFO - 'talos.zip': {'path': '', 01:40:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:40:22 INFO - Running post-action listener: _resource_record_post_action 01:40:22 INFO - ##### 01:40:22 INFO - ##### Running create-virtualenv step. 01:40:22 INFO - ##### 01:40:22 INFO - Running pre-action listener: _resource_record_pre_action 01:40:22 INFO - Running main action method: create_virtualenv 01:40:22 INFO - Creating virtualenv /builds/slave/test/build/venv 01:40:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:40:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:40:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:40:22 INFO - Using real prefix '/tools/python27' 01:40:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:40:23 INFO - Installing distribute.............................................................................................................................................................................................done. 01:40:25 INFO - Installing pip.................done. 01:40:26 INFO - Return code: 0 01:40:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11014ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11015c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ad85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffebe00>, '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 0x10fe54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffe6b20>, '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.ntq17foTAs/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.ohcJ90Op8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:40:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ntq17foTAs/Render', 01:40:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:40:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:40:26 INFO - 'HOME': '/Users/cltbld', 01:40:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:40:26 INFO - 'LOGNAME': 'cltbld', 01:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:26 INFO - 'MOZ_NO_REMOTE': '1', 01:40:26 INFO - 'NO_EM_RESTART': '1', 01:40:26 INFO - 'PAGER': '/bin/cat', 01:40:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:26 INFO - 'PWD': '/builds/slave/test', 01:40:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:40:26 INFO - 'SHELL': '/bin/bash', 01:40:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ohcJ90Op8u/Listeners', 01:40:26 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 01:40:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:40:26 INFO - 'USER': 'cltbld', 01:40:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:40:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:26 INFO - 'XPC_FLAGS': '0x0', 01:40:26 INFO - 'XPC_SERVICE_NAME': '0', 01:40:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:40:26 INFO - Cleaning up... 01:40:26 INFO - Return code: 0 01:40:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11014ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11015c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ad85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffebe00>, '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 0x10fe54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffe6b20>, '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.ntq17foTAs/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.ohcJ90Op8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:40:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ntq17foTAs/Render', 01:40:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:40:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:40:26 INFO - 'HOME': '/Users/cltbld', 01:40:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:40:26 INFO - 'LOGNAME': 'cltbld', 01:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:26 INFO - 'MOZ_NO_REMOTE': '1', 01:40:26 INFO - 'NO_EM_RESTART': '1', 01:40:26 INFO - 'PAGER': '/bin/cat', 01:40:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:26 INFO - 'PWD': '/builds/slave/test', 01:40:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:40:26 INFO - 'SHELL': '/bin/bash', 01:40:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ohcJ90Op8u/Listeners', 01:40:26 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 01:40:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:40:26 INFO - 'USER': 'cltbld', 01:40:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:40:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:26 INFO - 'XPC_FLAGS': '0x0', 01:40:26 INFO - 'XPC_SERVICE_NAME': '0', 01:40:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:26 INFO - Downloading/unpacking psutil>=0.7.1 01:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:40:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:29 INFO - Installing collected packages: psutil 01:40:29 INFO - Running setup.py install for psutil 01:40:29 INFO - building 'psutil._psutil_osx' extension 01:40:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:40:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:40:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:40:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:40:30 INFO - building 'psutil._psutil_posix' extension 01:40:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:40:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:40:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:40:30 INFO - ^ 01:40:30 INFO - 1 warning generated. 01:40:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:40:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:30 INFO - Successfully installed psutil 01:40:30 INFO - Cleaning up... 01:40:30 INFO - Return code: 0 01:40:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:30 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 0x11014ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11015c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ad85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffebe00>, '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 0x10fe54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffe6b20>, '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.ntq17foTAs/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.ohcJ90Op8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:40:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ntq17foTAs/Render', 01:40:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:40:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:40:30 INFO - 'HOME': '/Users/cltbld', 01:40:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:40:30 INFO - 'LOGNAME': 'cltbld', 01:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:30 INFO - 'MOZ_NO_REMOTE': '1', 01:40:30 INFO - 'NO_EM_RESTART': '1', 01:40:30 INFO - 'PAGER': '/bin/cat', 01:40:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:30 INFO - 'PWD': '/builds/slave/test', 01:40:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:40:30 INFO - 'SHELL': '/bin/bash', 01:40:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ohcJ90Op8u/Listeners', 01:40:30 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 01:40:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:40:30 INFO - 'USER': 'cltbld', 01:40:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:40:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:30 INFO - 'XPC_FLAGS': '0x0', 01:40:30 INFO - 'XPC_SERVICE_NAME': '0', 01:40:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:40:33 INFO - Installing collected packages: mozsystemmonitor 01:40:33 INFO - Running setup.py install for mozsystemmonitor 01:40:33 INFO - Successfully installed mozsystemmonitor 01:40:33 INFO - Cleaning up... 01:40:33 INFO - Return code: 0 01:40:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:33 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 0x11014ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11015c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ad85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffebe00>, '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 0x10fe54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffe6b20>, '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.ntq17foTAs/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.ohcJ90Op8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:40:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ntq17foTAs/Render', 01:40:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:40:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:40:33 INFO - 'HOME': '/Users/cltbld', 01:40:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:40:33 INFO - 'LOGNAME': 'cltbld', 01:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:33 INFO - 'MOZ_NO_REMOTE': '1', 01:40:33 INFO - 'NO_EM_RESTART': '1', 01:40:33 INFO - 'PAGER': '/bin/cat', 01:40:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:33 INFO - 'PWD': '/builds/slave/test', 01:40:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:40:33 INFO - 'SHELL': '/bin/bash', 01:40:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ohcJ90Op8u/Listeners', 01:40:33 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 01:40:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:40:33 INFO - 'USER': 'cltbld', 01:40:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:40:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:33 INFO - 'XPC_FLAGS': '0x0', 01:40:33 INFO - 'XPC_SERVICE_NAME': '0', 01:40:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:33 INFO - Downloading/unpacking blobuploader==1.2.4 01:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:36 INFO - Downloading blobuploader-1.2.4.tar.gz 01:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:40:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:40:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:37 INFO - Downloading docopt-0.6.1.tar.gz 01:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:40:37 INFO - Installing collected packages: blobuploader, requests, docopt 01:40:37 INFO - Running setup.py install for blobuploader 01:40:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:40:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:40:37 INFO - Running setup.py install for requests 01:40:38 INFO - Running setup.py install for docopt 01:40:38 INFO - Successfully installed blobuploader requests docopt 01:40:38 INFO - Cleaning up... 01:40:38 INFO - Return code: 0 01:40:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:40: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')]} 01:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40: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')]} 01:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:38 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 0x11014ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11015c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ad85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffebe00>, '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 0x10fe54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffe6b20>, '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.ntq17foTAs/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.ohcJ90Op8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:40:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:40:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ntq17foTAs/Render', 01:40:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:40:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:40:38 INFO - 'HOME': '/Users/cltbld', 01:40:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:40:38 INFO - 'LOGNAME': 'cltbld', 01:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:38 INFO - 'MOZ_NO_REMOTE': '1', 01:40:38 INFO - 'NO_EM_RESTART': '1', 01:40:38 INFO - 'PAGER': '/bin/cat', 01:40:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:38 INFO - 'PWD': '/builds/slave/test', 01:40:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:40:38 INFO - 'SHELL': '/bin/bash', 01:40:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ohcJ90Op8u/Listeners', 01:40:38 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 01:40:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:40:38 INFO - 'USER': 'cltbld', 01:40:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:40:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:38 INFO - 'XPC_FLAGS': '0x0', 01:40:38 INFO - 'XPC_SERVICE_NAME': '0', 01:40:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:40:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ChZP_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:40:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-fZu5zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:40:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Bahed0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:40:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-bLNMGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:40:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-qKgBKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:40:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-dnMV_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:40:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-fUJ8vN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:40:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-WaOtRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:40:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-x2Tt1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:40:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Q0Y_S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:40:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-NmXBoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:40:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-CwYdt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:40:40 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ju6ZPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:40:40 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-w0zGle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:40 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-qOiuMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:40:40 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-j5M3js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:40:40 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Oq1ksE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:40:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:40:40 INFO - Running setup.py install for manifestparser 01:40:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:40:40 INFO - Running setup.py install for mozcrash 01:40:40 INFO - Running setup.py install for mozdebug 01:40:40 INFO - Running setup.py install for mozdevice 01:40:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:40:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:40:41 INFO - Running setup.py install for mozfile 01:40:41 INFO - Running setup.py install for mozhttpd 01:40:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:40:41 INFO - Running setup.py install for mozinfo 01:40:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:40:41 INFO - Running setup.py install for mozInstall 01:40:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:40:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:40:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:40:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:40:41 INFO - Running setup.py install for mozleak 01:40:41 INFO - Running setup.py install for mozlog 01:40:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:40:42 INFO - Running setup.py install for moznetwork 01:40:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:40:42 INFO - Running setup.py install for mozprocess 01:40:42 INFO - Running setup.py install for mozprofile 01:40:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:40:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:40:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:40:42 INFO - Running setup.py install for mozrunner 01:40:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:40:42 INFO - Running setup.py install for mozscreenshot 01:40:42 INFO - Running setup.py install for moztest 01:40:43 INFO - Running setup.py install for mozversion 01:40:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:40:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:40:43 INFO - Cleaning up... 01:40:43 INFO - Return code: 0 01:40:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:43 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 0x11014ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11015c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ad85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffebe00>, '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 0x10fe54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffe6b20>, '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.ntq17foTAs/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.ohcJ90Op8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:40:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:40:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ntq17foTAs/Render', 01:40:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:40:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:40:43 INFO - 'HOME': '/Users/cltbld', 01:40:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:40:43 INFO - 'LOGNAME': 'cltbld', 01:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:43 INFO - 'MOZ_NO_REMOTE': '1', 01:40:43 INFO - 'NO_EM_RESTART': '1', 01:40:43 INFO - 'PAGER': '/bin/cat', 01:40:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:43 INFO - 'PWD': '/builds/slave/test', 01:40:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:40:43 INFO - 'SHELL': '/bin/bash', 01:40:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ohcJ90Op8u/Listeners', 01:40:43 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 01:40:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:40:43 INFO - 'USER': 'cltbld', 01:40:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:40:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:43 INFO - 'XPC_FLAGS': '0x0', 01:40:43 INFO - 'XPC_SERVICE_NAME': '0', 01:40:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:40:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-4q5nEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:40:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-qxYk8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:40:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-RpN7v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:40:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-G34RoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:40:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-4sx2xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:40:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-V0FXOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:40:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-NF4TFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:40:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-SZc6nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:40:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-SywQWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:40:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-VOFK0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:40:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-i67FXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:40:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-1LLTpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:40:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-TpVVd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:40:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-mxCh0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-v7Cbn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:40:45 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-vnNPol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:40:45 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-pFYYGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:40:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:47 INFO - Downloading blessings-1.6.tar.gz 01:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:40:47 INFO - Installing collected packages: blessings 01:40:47 INFO - Running setup.py install for blessings 01:40:47 INFO - Successfully installed blessings 01:40:47 INFO - Cleaning up... 01:40:48 INFO - Return code: 0 01:40:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:40:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:40:48 INFO - Reading from file tmpfile_stdout 01:40:48 INFO - Current package versions: 01:40:48 INFO - blessings == 1.6 01:40:48 INFO - blobuploader == 1.2.4 01:40:48 INFO - docopt == 0.6.1 01:40:48 INFO - manifestparser == 1.1 01:40:48 INFO - mozInstall == 1.12 01:40:48 INFO - mozcrash == 0.17 01:40:48 INFO - mozdebug == 0.1 01:40:48 INFO - mozdevice == 0.48 01:40:48 INFO - mozfile == 1.2 01:40:48 INFO - mozhttpd == 0.7 01:40:48 INFO - mozinfo == 0.9 01:40:48 INFO - mozleak == 0.1 01:40:48 INFO - mozlog == 3.1 01:40:48 INFO - moznetwork == 0.27 01:40:48 INFO - mozprocess == 0.22 01:40:48 INFO - mozprofile == 0.28 01:40:48 INFO - mozrunner == 6.11 01:40:48 INFO - mozscreenshot == 0.1 01:40:48 INFO - mozsystemmonitor == 0.0 01:40:48 INFO - moztest == 0.7 01:40:48 INFO - mozversion == 1.4 01:40:48 INFO - psutil == 3.1.1 01:40:48 INFO - requests == 1.2.3 01:40:48 INFO - wsgiref == 0.1.2 01:40:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:48 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 0x11014ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11015c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ad85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffebe00>, '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 0x10fe54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffe6b20>, '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.ntq17foTAs/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.ohcJ90Op8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:40:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:40:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ntq17foTAs/Render', 01:40:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:40:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:40:48 INFO - 'HOME': '/Users/cltbld', 01:40:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:40:48 INFO - 'LOGNAME': 'cltbld', 01:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:48 INFO - 'MOZ_NO_REMOTE': '1', 01:40:48 INFO - 'NO_EM_RESTART': '1', 01:40:48 INFO - 'PAGER': '/bin/cat', 01:40:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:48 INFO - 'PWD': '/builds/slave/test', 01:40:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:40:48 INFO - 'SHELL': '/bin/bash', 01:40:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ohcJ90Op8u/Listeners', 01:40:48 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 01:40:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:40:48 INFO - 'USER': 'cltbld', 01:40:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:40:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:48 INFO - 'XPC_FLAGS': '0x0', 01:40:48 INFO - 'XPC_SERVICE_NAME': '0', 01:40:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:40:48 INFO - Cleaning up... 01:40:48 INFO - Return code: 0 01:40:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:48 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 0x11014ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11015c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ad85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffebe00>, '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 0x10fe54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffe6b20>, '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.ntq17foTAs/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.ohcJ90Op8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:40:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:40:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ntq17foTAs/Render', 01:40:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:40:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:40:48 INFO - 'HOME': '/Users/cltbld', 01:40:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:40:48 INFO - 'LOGNAME': 'cltbld', 01:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:48 INFO - 'MOZ_NO_REMOTE': '1', 01:40:48 INFO - 'NO_EM_RESTART': '1', 01:40:48 INFO - 'PAGER': '/bin/cat', 01:40:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:48 INFO - 'PWD': '/builds/slave/test', 01:40:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:40:48 INFO - 'SHELL': '/bin/bash', 01:40:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ohcJ90Op8u/Listeners', 01:40:48 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 01:40:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:40:48 INFO - 'USER': 'cltbld', 01:40:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:40:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:48 INFO - 'XPC_FLAGS': '0x0', 01:40:48 INFO - 'XPC_SERVICE_NAME': '0', 01:40:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:48 INFO - Downloading/unpacking jsonschema 01:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:40:51 INFO - Downloading/unpacking functools32 (from jsonschema) 01:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:51 INFO - Downloading functools32-3.2.3-2.tar.gz 01:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:40:51 INFO - warning: no files found matching '*.txt' 01:40:51 INFO - no previously-included directories found matching 'build' 01:40:51 INFO - no previously-included directories found matching 'dist' 01:40:51 INFO - no previously-included directories found matching '.git*' 01:40:51 INFO - Installing collected packages: jsonschema, functools32 01:40:51 INFO - Running setup.py install for functools32 01:40:51 INFO - warning: no files found matching '*.txt' 01:40:51 INFO - no previously-included directories found matching 'build' 01:40:51 INFO - no previously-included directories found matching 'dist' 01:40:51 INFO - no previously-included directories found matching '.git*' 01:40:51 INFO - Successfully installed jsonschema functools32 01:40:51 INFO - Cleaning up... 01:40:52 INFO - Return code: 0 01:40:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11014ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11015c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ad85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffebe00>, '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 0x10fe54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffe6b20>, '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.ntq17foTAs/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.ohcJ90Op8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ntq17foTAs/Render', 01:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:40:52 INFO - 'HOME': '/Users/cltbld', 01:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:40:52 INFO - 'LOGNAME': 'cltbld', 01:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:52 INFO - 'MOZ_NO_REMOTE': '1', 01:40:52 INFO - 'NO_EM_RESTART': '1', 01:40:52 INFO - 'PAGER': '/bin/cat', 01:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:52 INFO - 'PWD': '/builds/slave/test', 01:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:40:52 INFO - 'SHELL': '/bin/bash', 01:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ohcJ90Op8u/Listeners', 01:40:52 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 01:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:40:52 INFO - 'USER': 'cltbld', 01:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:52 INFO - 'XPC_FLAGS': '0x0', 01:40:52 INFO - 'XPC_SERVICE_NAME': '0', 01:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:52 INFO - Downloading/unpacking flake8 01:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:40:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:40:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:40:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:40:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:40:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:40:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:40:56 INFO - no previously-included directories found matching 'docs/_build' 01:40:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:40:56 INFO - Running setup.py install for pep8 01:40:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:40:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:40:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:40:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:40:56 INFO - no previously-included directories found matching 'docs/_build' 01:40:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:40:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:40:56 INFO - Cleaning up... 01:40:56 INFO - Return code: 0 01:40:56 INFO - Running post-action listener: _resource_record_post_action 01:40:56 INFO - Running post-action listener: _start_resource_monitoring 01:40:56 INFO - Starting resource monitoring. 01:40:56 INFO - ##### 01:40:56 INFO - ##### Running install step. 01:40:56 INFO - ##### 01:40:56 INFO - Running pre-action listener: _resource_record_pre_action 01:40:56 INFO - Running main action method: install 01:40:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:40:56 INFO - Reading from file tmpfile_stdout 01:40:56 INFO - Detecting whether we're running mozinstall >=1.0... 01:40:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:40:56 INFO - Reading from file tmpfile_stdout 01:40:56 INFO - Output received: 01:40:56 INFO - Usage: mozinstall [options] installer 01:40:56 INFO - Options: 01:40:56 INFO - -h, --help show this help message and exit 01:40:56 INFO - -d DEST, --destination=DEST 01:40:56 INFO - Directory to install application into. [default: 01:40:56 INFO - "/builds/slave/test"] 01:40:56 INFO - --app=APP Application being installed. [default: firefox] 01:40:56 INFO - mkdir: /builds/slave/test/build/application 01:40:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 01:41:18 INFO - Reading from file tmpfile_stdout 01:41:18 INFO - Output received: 01:41:18 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:41:18 INFO - Running post-action listener: _resource_record_post_action 01:41:18 INFO - ##### 01:41:18 INFO - ##### Running run-tests step. 01:41:18 INFO - ##### 01:41:18 INFO - Running pre-action listener: _resource_record_pre_action 01:41:18 INFO - Running main action method: run_tests 01:41:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:41:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:41:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:41:18 INFO - 2016-06-07 01:41:18.667 screenresolution[1666:7483] starting screenresolution argv=screenresolution get 01:41:18 INFO - 2016-06-07 01:41:18.670 screenresolution[1666:7483] Display 0: 1600x1200x32@60 01:41:18 INFO - 2016-06-07 01:41:18.675 screenresolution[1667:7485] starting screenresolution argv=screenresolution list 01:41:18 INFO - Available Modes on Display 0 01:41:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:41:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:41:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:41:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:41:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:41:18 INFO - Intel Iris: 01:41:18 INFO - Chipset Model: Intel Iris 01:41:18 INFO - Type: GPU 01:41:18 INFO - Bus: Built-In 01:41:18 INFO - VRAM (Dynamic, Max): 1536 MB 01:41:18 INFO - Vendor: Intel (0x8086) 01:41:18 INFO - Device ID: 0x0a2e 01:41:18 INFO - Revision ID: 0x0009 01:41:18 INFO - Displays: 01:41:18 INFO - Display: 01:41:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:41:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:41:18 INFO - Display Serial Number: 1600x1200 60 01:41:18 INFO - Main Display: Yes 01:41:18 INFO - Mirror: Off 01:41:18 INFO - Online: Yes 01:41:18 INFO - Rotation: Supported 01:41:18 INFO - Return code: 0 01:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:41:18 INFO - Python 2.7.3 01:41:18 INFO - Return code: 0 01:41:18 INFO - grabbing minidump binary from tooltool 01:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:18 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 0x10ffebe00>, '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 0x10fe54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffe6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:41:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:41:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:41:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:41:18 INFO - Return code: 0 01:41:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:41:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:41:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:41:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:41:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:41:20 INFO - Return code: 0 01:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:41:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ntq17foTAs/Render', 01:41:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:41:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:41:20 INFO - 'HOME': '/Users/cltbld', 01:41:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:41:20 INFO - 'LOGNAME': 'cltbld', 01:41:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:41:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:20 INFO - 'MOZ_NO_REMOTE': '1', 01:41:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:41:20 INFO - 'NO_EM_RESTART': '1', 01:41:20 INFO - 'PAGER': '/bin/cat', 01:41:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:41:20 INFO - 'PWD': '/builds/slave/test', 01:41:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:41:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:41:20 INFO - 'SHELL': '/bin/bash', 01:41:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ohcJ90Op8u/Listeners', 01:41:20 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 01:41:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:41:20 INFO - 'USER': 'cltbld', 01:41:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:41:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:20 INFO - 'XPC_FLAGS': '0x0', 01:41:20 INFO - 'XPC_SERVICE_NAME': '0', 01:41:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:41:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:41:20 INFO - mozversion application_buildid: 20160606194329 01:41:20 INFO - mozversion application_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 01:41:20 INFO - mozversion application_display_name: Firefox 01:41:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:41:20 INFO - mozversion application_name: Firefox 01:41:20 INFO - mozversion application_remotingname: firefox 01:41:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:41:20 INFO - mozversion application_vendor: Mozilla 01:41:20 INFO - mozversion application_version: 48.0 01:41:20 INFO - mozversion platform_buildid: 20160606194329 01:41:20 INFO - mozversion platform_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 01:41:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:41:20 INFO - mozversion platform_version: 48.0 01:41:20 INFO - using testdate: 1465288880 01:41:20 INFO - actual date: 1465288880 01:41:20 INFO - starting webserver on 'localhost:49275' 01:41:20 INFO - SUITE-START | Running 2 tests 01:41:20 INFO - TEST-START | dromaeo_css 01:41:20 INFO - operating with platform_type : mac_ 01:41:20 INFO - Initialising browser for dromaeo_css test... 01:41:20 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpSk6QrS/profile http://localhost:49275/getInfo.html) 01:41:22 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 01:41:22 INFO - PROCESS | 1685 | colorDepth:24 01:41:22 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 01:41:22 INFO - PROCESS | 1685 | __metrics 01:41:22 INFO - PROCESS | 1685 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:41:22 ERROR - PROCESS | 1685 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:41:23 INFO - TEST-INFO | 1685: exit 0 01:41:23 INFO - Browser initialized. 01:41:23 INFO - Running cycle 1/1 for dromaeo_css test... 01:41:23 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpSk6QrS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:41:35 INFO - PROCESS | 1688 | RSS: Main: 161689600 01:41:35 INFO - PROCESS | 1688 | 01:42:26 INFO - PROCESS | 1688 | 1465288946771 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:44:36 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 01:44:38 INFO - PROCESS | 1688 | RSS: Main: 296263680 01:44:38 INFO - PROCESS | 1688 | 01:47:41 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 01:47:41 INFO - PROCESS | 1688 | RSS: Main: 296144896 01:47:41 INFO - PROCESS | 1688 | 01:50:43 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 01:50:44 INFO - PROCESS | 1688 | RSS: Main: 306364416 01:50:44 INFO - PROCESS | 1688 | 01:53:46 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 01:53:46 INFO - PROCESS | 1688 | RSS: Main: 300961792 01:53:46 INFO - PROCESS | 1688 | 01:56:50 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 01:56:50 INFO - PROCESS | 1688 | RSS: Main: 269598720 01:56:50 INFO - PROCESS | 1688 | 01:59:53 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 01:59:53 INFO - PROCESS | 1688 | RSS: Main: 311570432 01:59:53 INFO - PROCESS | 1688 | 01:59:53 INFO - PROCESS | 1688 | __start_tp_report 01:59:53 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 01:59:53 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 01:59:53 INFO - PROCESS | 1688 | |i|pagename|runs| 01:59:53 INFO - PROCESS | 1688 | |0;dojo.html;3468.23698786267;3547.5920269169055;3549.6627820357066;3552.4671299305087;3613.187032917592;5895.646261224319;5939.64362138272;5954.612950158236;5962.672053037081;5969.044952807551;5890.263717035371;5947.226860508139;5950.196723442334;5952.642841429517;5971.4625683688455;4375.781210939456;5230.686158830464;5305.151175811861;5336.332958380202;5387.515123638872;5316.043112239795;5368.597355198356;5373.919391209115;5395.460453954593;5403.918941215865;5248.658837175591;5320.547753440943;5341.866453338678;5361.571074314045;5371.785128594852;5334.03987282289;5343.278657381243;5361.142217245261;5379.462053794628;5386.91919621206;4395.78021098947;5122.667026643294;5259.105951988171;5301.893962120775;5304.787808487656;5612.989661860864;5674.404187560329;5680.289963754531;5712.971435142839;5739.713014349266;6251.562390632657;6264.937350626481;6269.561130720851;6283.340249273806;6286.057091436275;5534.916976245359;6213.161223234851;6259.467945224661;6261.373862613747;6272.905906411407;5869.530437564985;5907.940920590739;5983.670898100646;5985.700714964234;5994.520438364964;5391.784328626811;6319.842003949938;6365.172527571386;6372.968135159294;6376.808695739135;6078.149059131725;6180.5673602848265;6249.812505624747;6256.906146407808;6262.624242545462;6270.0908368287255;6281.309056003836;6282.748690052438;6318.778842740482;6402.807915762534;6275.529335299871;6290.24517057956;6306.968465157736;6313.305536390993;6322.652254126067;6161.014237721943;6227.9377206227355;6292.905606415908;6294.559380843389;6304;4955.554000139932;4982.975085124551;4992.076465853756;5000.724960127155;5043.36957880265;4495.88760280989;4501.099780044005;4504.887377815516;4510.977445112753;4544.182047231464;4950.851474455772;5953.851153721105;5955.434233747787;5957;5958.285005799332;6214.1921550198185;6247.750089996349;6255.374462553708;6258.123862659231;6260.092286618415;5922;5937.643741375531;5941.55438342126;5953.077273022688;6069.846729121453;4247.384129301234;5453.7818487260065;5525.475079867406;5538.806141785099;5551.916721249185;6253.1245625612455;6360.713767880549;6452.322506136788;6453.612783233021;6476.287608363076;6190.7523699051535;6198.535109866688;6253.687315634291;6255.186825712628;6266.342034086538;6432.00303952888;6435.517336199898;6459.095726598186;6459.354064593503;6469.191351081115;6139.584134579286;6200.100985357189;6234.438900498977;6283.622982621057;6303.653299068412;6262.34245404226;6272.247330320391;6285.120083188449;6285.1515045470105;6295;5245.501677340799;6179.907301390573;6261.060840873905;6272.874542509216;6279.560430769802;5907.379725128972;6141.608749743955;6143.112737013596;6208.1308616792785;6244.344343843831;6099.993501072451;6104.969475152596;6133.969330153321;6138.662373569497;6158.876822463615;6228.408301211378;6232.501399887908;6246.094316324016;6248.656323902229;6253.187085678833;6011.428914253139;6067.211262536019;6148.631082135086;6150.569460137747;6167.167432396748 01:59:53 INFO - PROCESS | 1688 | |1;ext.html;541.0990700483694;562.3139769481234;574.43131300013;575.8122743682311;578.3926876779382;34262.314753704944;39720.42516173544;40619.9845003875;40659.39010914831;40977.59022409775;46231.84420389492;46472.3029154563;46602.53397466024;46611.53388466114;46687.766561167235;9036.367454278203;9897.653582124627;10094.697159085203;10108.44403557804;11662.941685291562;11839.467223974942;11966.940165299162;11969.341686207255;11971.7605647887;11976.880231197707;11913.94043029788;11973;11980.34108124053;12000.51997920082;12096.33470159141;8204.630791614392;9295.256379489658;9515.191208747265;9517.666881659108;11909.880901190963;11868.703282418008;12169.330686812222;12172.330521821295;12181.33002684852;12184.329861857594;40820.77537673845;41250.79374603138;41300;41369.79315103405;41611;3361.210115622827;3368.59576850777;3478.113081164312;3617.439296908983;3653.4702468142236;27917.720822791714;27968.86015569909;28068.859655701795;28309.43381132366;29028.27429314263;2670.0254407141447;2670.425858440425;2685.717999610032;2761.0336382266046;2776.5141100307364;450797;450855;451451;451740;452324;63125.73748525095;63176;63786.36213637897;63951;64716.676416617614;71254.64372678207;71551;71682.20794480076;71804.64097679478;71905.64047179835;18406.447806565557;19072.90463547701;19077.618447630968;19083.522911927033;19092.713609295595;13185.73628527424;13468.461261549624;14416.990810643365;14798.704025919636;14808.62978425548;18816.47420330068;19344.613107737765;19681.704774428108;20150;20876.686849697267;7172.677229524684;7563.73526926566;8430.48251314757;8454.239118479367;8466.280366168945;970.427447805798;1040.47976011994;1046.7173863057085;1129.4522156753967;1133.3539882267028;30448;30877.8456107718;30934.22664433407;31389.843050785057;31474.527882081788;1164.8875324065498;1234.4383305596111;1235.9011279097651;1236.258245052979;1301.44688507384;13231.404586793617;15538.922305388627;15823.604409889615;15910.363585456684;16275.918620406823;618880;624339;628161;633860;633924;51214.74392628013;63534;63659.363406365344;63762;64115;1278.878506541877;1426.771716525351;1501.4144483651603;1576.9211539422984;1588.3884704388663;26334.34164145835;29294.41411171722;30588.08235752931;30870.073897783102;31239.219019524695;39465.60534394619;43100.56899431091;51830.222546661076;52289;52318.47681523136;445984;447198;447626;449334;449509;23943.760562394153;23988.920498577256;25401.364965876;28481.145565633065;28539.714602853706;45102.77448612736;45221.095578087596;45475.77262113668;46933.06133877235;47214.76392618015;36265.09337266589;37434.62565374311;37577.872663820126;38153.61846381501;38454.2309153821;29172.708272917;32695.836520817244;34254.82872585621;37072.81463592665;37775;37405.87782366533;38065.4290185653;38742.03144921287;38771;39043.804780975915;32252.677473225907;33936.66063339335;33981;34029.65970340265;34055;25418.745812541638;25686.61470077913;25724.39353099668;25836.8708156458;26237.737622624292 01:59:53 INFO - PROCESS | 1688 | |2;jquery.html;357.62270804301465;416.5189206466528;418.9643880270175;423.881313232295;438.064731797612;14934;20428.28501002465;21172.364829055135;21177.894110529443;21511.892440537777;21177.364679059614;21482.570348593057;22288.442788930286;22517.774822251773;22528;4776.665633405654;5889.146073819294;6193.234928045508;6194.876102477948;6203.2245969253845;5868.735906884179;6111.816645500619;6147.754089836423;6179.258488981306;6216.067589861512;6187.814365569017;6209.658468784215;6217.347178546255;6224.284207316148;6228.719707613146;5843.094320380326;6175.07373893915;6179.0422484514975;6185.628862268279;6199.907001394983;5732.484076433099;5995.700214989277;6035.879282414371;6040.848978775522;6070.635761854259;14187.929060354736;14240.572782816533;14402.855971440256;14498.637534061627;14564;2289.0843662534953;2377.3937645900187;2385.85684858909;2598.363400966756;2639.0499420208707;9966.352187107886;10037;10057.849132263022;10480.266381353309;10495.370277783357;1798.5413719501444;1804.7653805005395;1832.221305944968;1850.8796928199758;1927.0557426860737;93935.06064939332;121427;121850;121852.17221741681;127159;11843.460350154424;12003.759924801456;12047.819282710767;12192.390380481118;12313.537292541349;14259.287035648176;14848.62878428048;15118.546443606709;15816.525504234662;15859.682806344039;9122.589483473259;9274.258059355236;9398.812023759623;9406.623735050658;9469.715908522756;9427.717168484956;9462.243020558339;9479.431234125974;9555;9567.61729530811;4308.1814455254025;4487.057717879216;4733.786979585927;4806.447258565309;4837.419509658864;1831.5238038110188;1964.145596665455;1978.4262563856607;2040.795920407977;2053.219776484926;936.5317341329335;979.397670432693;1024.3444195714749;1047.1151876664208;1080;17754.289828406978;20682;21401.571968560853;21651.312011584712;21691.45771355697;1005.2962925951863;1014.6803756816579;1015.6292953072076;1085.9294145880492;1110.1119104716195;10899.727506812393;11456.369899655432;11491.138164637685;11492.023178029962;11509.827352589718;630739;647782;648264;648909;669772;132302;132317;135909.87920254722;137243;139412;1025.553884060436;1027.7893031928586;1035.249444152983;1044.2272718188485;1068.1188019883782;18744.7188292173;18867.90566047161;19014.144363503397;19018;19296;40938.795306023276;49797.75101124471;51480.45558633247;54033.378998630105;57609.711951439975;67683.66158169178;70002.64998674973;70649;70789;72311.27688723255;8119.4722343047515;8349.791255218668;8506.106858779738;8514.91485085166;8522.74431767048;9440.763980900532;12788.616341509769;12931.870681293443;13078.411471483996;13363.866361336262;11159.072741806685;11311.943440282746;11324.773504530029;11340.09279257641;11739.471723772622;10956.506957186786;11163;11174.608888688857;11490.77018459643;11680.007199388147;9349.719508414759;11371.488283027118;11488.425578721197;11509.079273658255;11907.16649834538;8212.794680133044;8279.213474719892;8355.874661880198;8392.328613710766;8533;8546.145385461405;10867.021968022917;11138.94430527842;11245.044171245536;11452.599159029394 01:59:53 INFO - PROCESS | 1688 | |3;mootools.html;1380.9447622095117;1483.3992233145566;1607.863331616813;1830.4874635102176;2012.8691635043713;8287.088420273772;8940.642374305027;9048.230900373459;9079.591418386171;9135.223506001981;8474.449160804543;8740.606672699729;8745.475271483716;8749.562521873913;8792.8681069784;2515.383730985911;2547.7070136934212;2549.655796467481;2552.0940066276485;2553.2595547291357;2469.925902222927;2533.5946248600226;2535.2394281715506;2536.7843733282693;2540.530001949636;2509.2848538166627;2532.5441420544294;2549.7450254974447;2557.56521391363;2560.6927168739685;2121.7241758571363;2129.776373480793;2494.9376265593323;2522.495500899818;2546.2997675639162;2483.4784695214025;2514.7610976957158;2523.5079159563893;2527.873606319695;2538.504991526653;8750.47497150173;8812.427192232484;8876.334274929342;8886.955565222133;8982.505962172077;5597.916031259534;5837.270341207349;5852.707364631751;5862.208601838783;5866.648001119904;3603.94594081089;3663.853445862189;3721.0325315417917;3727.4408838674144;3741.8690345837763;1031.4481752262504;1034.6223628375665;1043.3218408034763;1053.9420331881743;1068.2415485005656;12111.849374309426;12334.75330493394;12354.196977196454;12364.505419783198;12367.62897113088;4747.311639812277;4768.642351823558;4786.114568804782;4802.056757848273;4845.127876982177;9511.952440237754;9519.476428796483;9547.188488978376;9550.474723890253;9587.18508926749;5562.110062390079;5567.49892509668;5568.081266591048;5568.9443105568425;5575.860603484945;4549.727016379028;4626.190416677068;4791.832285869978;4863.10032643962;5181.326427564468;3950.802459876995;3983.701222408273;4044.9595504045174;4062.614051665087;4076.5311989121633;1254.5295514182183;1272.4846437192953;1276.463885168213;1280.180684362009;1288.3043156695467;874.8381549413378;971.8095333216894;985.2659768472533;987.4223579206244;1027.2254481693221;6067.484263837623;6092;6164.47601953839;6275.341089185661;6299.055141728686;467.9836205732851;480.4186933810059;489.20015774209423;496.5803895708121;496.7913476339946;3420.743444241692;4060.4721386219603;4097.242010228118;4099.8360065597635;4129.442525259112;10931.234813563133;11435.199536032398;11481.598144064918;11486.597969071043;11487;10347.379157250589;10662.466876656135;10797.46012699362;10802.567897284178;10812.243142980073;8335.541545215072;8364;8532.402731808714;8567.74296771098;8609.65561377538;5162.819301324435;5836.270466191726;6017.608855424383;6067.605605635619;6262.68686565679;9609.135177834029;9872.35829671069;9890.406575605486;9945.950270248602;10031.54858031405;9744.658936937172;10295.176385889261;10306.948465257925;10494.842577361498;10518.053375196268;6913.204981426999;7608.353289970193;7832.647530861239;8130.959345203236;8669.523176225115;8460.57697115154;8462.492250464991;8525.786855328666;8533.957330213309;8561.44350617208;7385.7045718170675;7540.132884718328;7591.089069311718;7603.923960760543;7661.540307581563;7369.042024536776;7417.443691723251;7422.888656670262;7503.962480187564;7527.661255243418;7175.856482870209;7222.458315626244;7239.660662777403;7245.601491917995;7306.2693730626515;4941.555260026471;5014.548690617862;5060.544550990428;5132.769025393941;5167.1474206755465;5079.898402032012;5097.235414687826;5114.9232761507865;5176.7152806596;5356.625036247426 01:59:53 INFO - PROCESS | 1688 | |4;prototype.html;300.8931829200635;338.6156712131731;340.97783644063134;349.50544978854913;353.8814497143457;6752.493562982771;6753.763618273361;6767.966160169199;6768.3908448239645;6867.484938629598;5407;5670.716464176785;6763.086983257259;6778.220504641968;6801.591904485735;4195.7063005589625;4302.591253830897;4570.97714511427;4700.506446823086;5000.7249601271915;4092.815823287944;4947.183714687072;5010.624203184758;5013.398392192942;5017.569992552123;4942.629302802305;4954.653174277802;4961.950380496203;4973.378327709036;4984.675996060263;4330.614203454896;4765.761711914408;4839.830605928793;4974.552290293855;4987.900241995139;4064.593540645941;4230.2174097792;4260.8721738347895;4262.318029115327;4284.485861696617;6446.677666116675;6462.547621666486;6466.935330646727;6546.116274303004;6557.311482294386;5924.4667979882015;5950.880982380371;5954.136650185742;5959;5964.552658550626;6584.979328204136;6900.585964842126;6910.412614927737;7243.058402407653;7250.891236631454;4627.930581041287;4647.55848194421;4668.813247470097;4687.460941991681;4693.647976401783;7563.810904727371;7649.388048956126;7650.19672934345;7669.501482403682;7710.689182838931;4730.148573256778;4745.738984355825;4747.738874361874;4749.24012158053;4760.119377915097;4801.903961920742;4820.156472617348;4822.204336284544;4822.68652537584;4824.807007719652;5527.419620939824;5773.971130144407;5780.508656764222;5784.82645520635;5800.8259752207505;6124.938750612437;6898;7163.570185788869;7208.27917208275;7226.060612120391;1641.8686505079565;1675.7850558345103;1685.6207353345399;1686.8481836634762;1688.3921788156254;880.5553195636163;1000.6541202083187;1010.525053224983;1048.7535429174138;1072.8176210044312;5639.548836093103;6735.8989615155815;6864.691088901011;6872.041468181545;6891.689873955684;7547.660355284025;7549.698012079455;7559.130699969464;7574.545527268381;7581.203973582805;6847.897281540781;6853.314668533207;6855.897161542581;6868.725250989904;6881.724731010803;3829.5404551454003;3950.9849976512187;4001.919961600752;4002;4009.799510024487;7875.921240787518;7912.881306780288;7949.602519874099;7951.721689740832;7963.203679632106;7744.380449564022;7811.687532498637;7815.179406162385;7827.060752709711;7830.138684744674;6291.213598300213;7883.448158628956;7902.288794008567;7902.723404680809;7912.169222231698;7221.169565500035;7507.737229196952;7513.323800857949;7520.924790752022;7527.623618819147;6926.653667316715;7424.777256682308;7441.92558074434;7450.366718828744;7457.6271186441545;6721.932780672326;7865.134835168242;7894.644740986554;7897.012873390826;7898.328642065489;4729.290606409066;4730.810767569259;4744.928826067543;4747;4752.596029337406;7247.818804529718;7489.475736698379;7502;7522.360599348897;7541.698332066656;6357.078223657451;6892;7242.601656908921;7270.636468176464;7272.200057993511;7216.0258365120035;7223.386012189023;7252.673629686571;7258.673359698721;7260.709571617076;7086.964565177141;7098.538594991309;7108.822279443055;7112.288771122846;7120;6972.163340399185;7247.202807691045;7272.745453909088;7281.490295679251;7282.3809976152625;6862.519623626298;7011.719531218694;7060.823479413056;7152.9270609409;7203.423726101794 01:59:53 INFO - PROCESS | 1688 | |5;yui.html;711.4841739738694;719.4855678190092;727.127447063524;727.2182403915789;736.3630459652401;15237.314320855561;15465.536033918972;15486.303116359762;15491.535253942371;15513;14160.858391416108;14248.715025699506;14315.498957536489;14318.92840535796;14327.426902923871;669.5848573884186;788.2590365056828;797.9880301795478;939.6992962252082;966.0387914025555;972.8054389122168;973.7127547373542;975.1759763000254;975.5707488704948;978.1538968791979;1020.9948950255239;1035.8549803027581;1038.6624347087227;1040.2042437535292;1040.8438734189895;832.4672209785742;1000.2498126405196;1025.96409125681;1030.9896901030968;1031.6904928521415;767.0182166826471;769.2154002917049;770.730244414456;770.8843673449028;771.1902502372486;15352.462663806826;15406.075635461908;15406.922965385213;15410.460633877761;15516;12387.814182787266;12847;13032.86967130326;13223.074384793068;13223.999999999904;11074.335539867634;11377.715557111138;11421.657350279505;11636.069114470822;11654.125940554492;3094.6131733533307;3588.4617307403837;3608.855645774166;3636.6181550937035;3822.73240873139;73676.6316168421;74807;76565.61717191435;77271.613641932;90052.19895602117;10116.696499105039;10133.898661013443;10241.43672098027;10310.278280520291;10489.265751397481;23258.883705581364;23266.883665581903;23315.417114572272;23315.650265246033;23333.300000999996;7733.226677332222;7850.764477065697;7890.723824666109;7898.684052637945;8065.879011814827;4142.855000074983;4246.8301267949555;4249.192653395845;4303.354496825438;4494.775261236925;3770.811459427018;3822.9235415292096;3826.7895265760094;3828.980855095707;3831.214601006787;682.6757290287073;687.3435868745336;700.9824754381182;703.7607213547418;709.9432045436353;605.5518916002214;616.5499185594541;642.8232236135007;644.2591020326662;666.0275997044273;8190.344772418192;8537.786555336043;8611;8617.396782225183;8696.608652610521;608.4341562347059;620.0203678188451;625.7653379982506;629.6064959400375;639.990400143989;3836.7506112102624;3866.7873266970587;3905.511811023622;3979.2837289287627;4172.311568591149;71729.2827071733;93192.53403732937;96114.51942740241;96378;99256.01487970201;78102.6094869522;79736.20263797404;82349;83311.5834420824;83605.58197208976;72304.91542626865;72769;73416.63291683508;73777.6311118441;73794.52410951858;7958.562279074707;7962.601869906365;8069.798255043436;8121.715739949073;8467.322614190727;49405.75297123491;50234.49765502445;50471;51469.742651286506;51543.74228128985;66968.32579185559;68744;69537.65231173811;72274;73046;11196.104311655212;11213.159013074215;11277.661670149908;11313.830292545454;11545.48045337945;12124.93937530342;12171.39143042862;12290.385480726107;12332.753344933231;12755.61733148007;11627.476763545492;11640.94179529097;11817.172797904408;12131.939340303243;12246.632601021984;11405.429728513707;11775.941120294343;11795.705107372385;11802.704932376759;11822.054235661299;10529.736756581147;10682.092022178202;10694.465276736288;10835.349879007284;10939.726506837393;8950.881139857518;9058.954705226432;9706.466144362128;9982.401055936667;10062.949685251528;9775.755606109904;9799.216062715108;9927.900720992986;9984.750381240527;10085.142762865238 01:59:53 INFO - PROCESS | 1688 | __end_tp_report 01:59:53 INFO - PROCESS | 1688 | __start_cc_report 01:59:53 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,1161 01:59:53 INFO - PROCESS | 1688 | __end_cc_report 01:59:53 INFO - PROCESS | 1688 | __startTimestamp1465289993499__endTimestamp 01:59:53 INFO - PROCESS | 1688 | 01:59:53 INFO - PROCESS | 1688 | ------- Summary: start ------- 01:59:53 INFO - PROCESS | 1688 | Number of tests: 6 01:59:53 INFO - PROCESS | 1688 | 01:59:53 INFO - PROCESS | 1688 | [#0] dojo.html Cycles:165 Average:5816.27 Median:6099.99 stddev:652.70 (10.7%) stddev-sans-first:628.17 01:59:53 INFO - PROCESS | 1688 | Values: 3468.2 3547.6 3549.7 3552.5 3613.2 5895.6 5939.6 5954.6 5962.7 5969.0 5890.3 5947.2 5950.2 5952.6 5971.5 4375.8 5230.7 5305.2 5336.3 5387.5 5316.0 5368.6 5373.9 5395.5 5403.9 5248.7 5320.5 5341.9 5361.6 5371.8 5334.0 5343.3 5361.1 5379.5 5386.9 4395.8 5122.7 5259.1 5301.9 5304.8 5613.0 5674.4 5680.3 5713.0 5739.7 6251.6 6264.9 6269.6 6283.3 6286.1 5534.9 6213.2 6259.5 6261.4 6272.9 5869.5 5907.9 5983.7 5985.7 5994.5 5391.8 6319.8 6365.2 6373.0 6376.8 6078.1 6180.6 6249.8 6256.9 6262.6 6270.1 6281.3 6282.7 6318.8 6402.8 6275.5 6290.2 6307.0 6313.3 6322.7 6161.0 6227.9 6292.9 6294.6 6304.0 4955.6 4983.0 4992.1 5000.7 5043.4 4495.9 4501.1 4504.9 4511.0 4544.2 4950.9 5953.9 5955.4 5957.0 5958.3 6214.2 6247.8 6255.4 6258.1 6260.1 5922.0 5937.6 5941.6 5953.1 6069.8 4247.4 5453.8 5525.5 5538.8 5551.9 6253.1 6360.7 6452.3 6453.6 6476.3 6190.8 6198.5 6253.7 6255.2 6266.3 6432.0 6435.5 6459.1 6459.4 6469.2 6139.6 6200.1 6234.4 6283.6 6303.7 6262.3 6272.2 6285.1 6285.2 6295.0 5245.5 6179.9 6261.1 6272.9 6279.6 5907.4 6141.6 6143.1 6208.1 6244.3 6100.0 6105.0 6134.0 6138.7 6158.9 6228.4 6232.5 6246.1 6248.7 6253.2 6011.4 6067.2 6148.6 6150.6 6167.2 01:59:53 INFO - PROCESS | 1688 | 01:59:53 INFO - PROCESS | 1688 | [#1] ext.html Cycles:180 Average:65888.39 Median:34042.33 stddev:137442.62 (403.7%) stddev-sans-first:137740.61 01:59:53 INFO - PROCESS | 1688 | Values: 541.1 562.3 574.4 575.8 578.4 34262.3 39720.4 40620.0 40659.4 40977.6 46231.8 46472.3 46602.5 46611.5 46687.8 9036.4 9897.7 10094.7 10108.4 11662.9 11839.5 11966.9 11969.3 11971.8 11976.9 11913.9 11973.0 11980.3 12000.5 12096.3 8204.6 9295.3 9515.2 9517.7 11909.9 11868.7 12169.3 12172.3 12181.3 12184.3 40820.8 41250.8 41300.0 41369.8 41611.0 3361.2 3368.6 3478.1 3617.4 3653.5 27917.7 27968.9 28068.9 28309.4 29028.3 2670.0 2670.4 2685.7 2761.0 2776.5 450797.0 450855.0 451451.0 451740.0 452324.0 63125.7 63176.0 63786.4 63951.0 64716.7 71254.6 71551.0 71682.2 71804.6 71905.6 18406.4 19072.9 19077.6 19083.5 19092.7 13185.7 13468.5 14417.0 14798.7 14808.6 18816.5 19344.6 19681.7 20150.0 20876.7 7172.7 7563.7 8430.5 8454.2 8466.3 970.4 1040.5 1046.7 1129.5 1133.4 30448.0 30877.8 30934.2 31389.8 31474.5 1164.9 1234.4 1235.9 1236.3 1301.4 13231.4 15538.9 15823.6 15910.4 16275.9 618880.0 624339.0 628161.0 633860.0 633924.0 51214.7 63534.0 63659.4 63762.0 64115.0 1278.9 1426.8 1501.4 1576.9 1588.4 26334.3 29294.4 30588.1 30870.1 31239.2 39465.6 43100.6 51830.2 52289.0 52318.5 445984.0 447198.0 447626.0 449334.0 449509.0 23943.8 23988.9 25401.4 28481.1 28539.7 45102.8 45221.1 45475.8 46933.1 47214.8 36265.1 37434.6 37577.9 38153.6 38454.2 29172.7 32695.8 34254.8 37072.8 37775.0 37405.9 38065.4 38742.0 38771.0 39043.8 32252.7 33936.7 33981.0 34029.7 34055.0 25418.7 25686.6 25724.4 25836.9 26237.7 01:59:53 INFO - PROCESS | 1688 | 01:59:53 INFO - PROCESS | 1688 | [#2] jquery.html Cycles:180 Average:36237.60 Median:21442.07 stddev:108012.80 (503.7%) stddev-sans-first:108282.20 01:59:53 INFO - PROCESS | 1688 | Values: 357.6 416.5 419.0 423.9 438.1 14934.0 20428.3 21172.4 21177.9 21511.9 21177.4 21482.6 22288.4 22517.8 22528.0 4776.7 5889.1 6193.2 6194.9 6203.2 5868.7 6111.8 6147.8 6179.3 6216.1 6187.8 6209.7 6217.3 6224.3 6228.7 5843.1 6175.1 6179.0 6185.6 6199.9 5732.5 5995.7 6035.9 6040.8 6070.6 14187.9 14240.6 14402.9 14498.6 14564.0 2289.1 2377.4 2385.9 2598.4 2639.0 9966.4 10037.0 10057.8 10480.3 10495.4 1798.5 1804.8 1832.2 1850.9 1927.1 93935.1 121427.0 121850.0 121852.2 127159.0 11843.5 12003.8 12047.8 12192.4 12313.5 14259.3 14848.6 15118.5 15816.5 15859.7 9122.6 9274.3 9398.8 9406.6 9469.7 9427.7 9462.2 9479.4 9555.0 9567.6 4308.2 4487.1 4733.8 4806.4 4837.4 1831.5 1964.1 1978.4 2040.8 2053.2 936.5 979.4 1024.3 1047.1 1080.0 17754.3 20682.0 21401.6 21651.3 21691.5 1005.3 1014.7 1015.6 1085.9 1110.1 10899.7 11456.4 11491.1 11492.0 11509.8 630739.0 647782.0 648264.0 648909.0 669772.0 132302.0 132317.0 135909.9 137243.0 139412.0 1025.6 1027.8 1035.2 1044.2 1068.1 18744.7 18867.9 19014.1 19018.0 19296.0 40938.8 49797.8 51480.5 54033.4 57609.7 67683.7 70002.6 70649.0 70789.0 72311.3 8119.5 8349.8 8506.1 8514.9 8522.7 9440.8 12788.6 12931.9 13078.4 13363.9 11159.1 11311.9 11324.8 11340.1 11739.5 10956.5 11163.0 11174.6 11490.8 11680.0 9349.7 11371.5 11488.4 11509.1 11907.2 8212.8 8279.2 8355.9 8392.3 8533.0 8546.1 10867.0 11138.9 11245.0 11452.6 01:59:53 INFO - PROCESS | 1688 | 01:59:53 INFO - PROCESS | 1688 | [#3] mootools.html Cycles:180 Average:5844.79 Median:2755.67 stddev:3271.22 (118.7%) stddev-sans-first:3263.19 01:59:53 INFO - PROCESS | 1688 | Values: 1380.9 1483.4 1607.9 1830.5 2012.9 8287.1 8940.6 9048.2 9079.6 9135.2 8474.4 8740.6 8745.5 8749.6 8792.9 2515.4 2547.7 2549.7 2552.1 2553.3 2469.9 2533.6 2535.2 2536.8 2540.5 2509.3 2532.5 2549.7 2557.6 2560.7 2121.7 2129.8 2494.9 2522.5 2546.3 2483.5 2514.8 2523.5 2527.9 2538.5 8750.5 8812.4 8876.3 8887.0 8982.5 5597.9 5837.3 5852.7 5862.2 5866.6 3603.9 3663.9 3721.0 3727.4 3741.9 1031.4 1034.6 1043.3 1053.9 1068.2 12111.8 12334.8 12354.2 12364.5 12367.6 4747.3 4768.6 4786.1 4802.1 4845.1 9512.0 9519.5 9547.2 9550.5 9587.2 5562.1 5567.5 5568.1 5568.9 5575.9 4549.7 4626.2 4791.8 4863.1 5181.3 3950.8 3983.7 4045.0 4062.6 4076.5 1254.5 1272.5 1276.5 1280.2 1288.3 874.8 971.8 985.3 987.4 1027.2 6067.5 6092.0 6164.5 6275.3 6299.1 468.0 480.4 489.2 496.6 496.8 3420.7 4060.5 4097.2 4099.8 4129.4 10931.2 11435.2 11481.6 11486.6 11487.0 10347.4 10662.5 10797.5 10802.6 10812.2 8335.5 8364.0 8532.4 8567.7 8609.7 5162.8 5836.3 6017.6 6067.6 6262.7 9609.1 9872.4 9890.4 9946.0 10031.5 9744.7 10295.2 10306.9 10494.8 10518.1 6913.2 7608.4 7832.6 8131.0 8669.5 8460.6 8462.5 8525.8 8534.0 8561.4 7385.7 7540.1 7591.1 7603.9 7661.5 7369.0 7417.4 7422.9 7504.0 7527.7 7175.9 7222.5 7239.7 7245.6 7306.3 4941.6 5014.5 5060.5 5132.8 5167.1 5079.9 5097.2 5114.9 5176.7 5356.6 01:59:53 INFO - PROCESS | 1688 | 01:59:53 INFO - PROCESS | 1688 | [#4] prototype.html Cycles:180 Average:5887.61 Median:6765.53 stddev:1911.09 (28.2%) stddev-sans-first:1869.88 01:59:53 INFO - PROCESS | 1688 | Values: 300.9 338.6 341.0 349.5 353.9 6752.5 6753.8 6768.0 6768.4 6867.5 5407.0 5670.7 6763.1 6778.2 6801.6 4195.7 4302.6 4571.0 4700.5 5000.7 4092.8 4947.2 5010.6 5013.4 5017.6 4942.6 4954.7 4962.0 4973.4 4984.7 4330.6 4765.8 4839.8 4974.6 4987.9 4064.6 4230.2 4260.9 4262.3 4284.5 6446.7 6462.5 6466.9 6546.1 6557.3 5924.5 5950.9 5954.1 5959.0 5964.6 6585.0 6900.6 6910.4 7243.1 7250.9 4627.9 4647.6 4668.8 4687.5 4693.6 7563.8 7649.4 7650.2 7669.5 7710.7 4730.1 4745.7 4747.7 4749.2 4760.1 4801.9 4820.2 4822.2 4822.7 4824.8 5527.4 5774.0 5780.5 5784.8 5800.8 6124.9 6898.0 7163.6 7208.3 7226.1 1641.9 1675.8 1685.6 1686.8 1688.4 880.6 1000.7 1010.5 1048.8 1072.8 5639.5 6735.9 6864.7 6872.0 6891.7 7547.7 7549.7 7559.1 7574.5 7581.2 6847.9 6853.3 6855.9 6868.7 6881.7 3829.5 3951.0 4001.9 4002.0 4009.8 7875.9 7912.9 7949.6 7951.7 7963.2 7744.4 7811.7 7815.2 7827.1 7830.1 6291.2 7883.4 7902.3 7902.7 7912.2 7221.2 7507.7 7513.3 7520.9 7527.6 6926.7 7424.8 7441.9 7450.4 7457.6 6721.9 7865.1 7894.6 7897.0 7898.3 4729.3 4730.8 4744.9 4747.0 4752.6 7247.8 7489.5 7502.0 7522.4 7541.7 6357.1 6892.0 7242.6 7270.6 7272.2 7216.0 7223.4 7252.7 7258.7 7260.7 7087.0 7098.5 7108.8 7112.3 7120.0 6972.2 7247.2 7272.7 7281.5 7282.4 6862.5 7011.7 7060.8 7152.9 7203.4 01:59:53 INFO - PROCESS | 1688 | 01:59:53 INFO - PROCESS | 1688 | [#5] yui.html Cycles:180 Average:18697.88 Median:26950.26 stddev:26046.11 (96.6%) stddev-sans-first:26084.16 01:59:53 INFO - PROCESS | 1688 | Values: 711.5 719.5 727.1 727.2 736.4 15237.3 15465.5 15486.3 15491.5 15513.0 14160.9 14248.7 14315.5 14318.9 14327.4 669.6 788.3 798.0 939.7 966.0 972.8 973.7 975.2 975.6 978.2 1021.0 1035.9 1038.7 1040.2 1040.8 832.5 1000.2 1026.0 1031.0 1031.7 767.0 769.2 770.7 770.9 771.2 15352.5 15406.1 15406.9 15410.5 15516.0 12387.8 12847.0 13032.9 13223.1 13224.0 11074.3 11377.7 11421.7 11636.1 11654.1 3094.6 3588.5 3608.9 3636.6 3822.7 73676.6 74807.0 76565.6 77271.6 90052.2 10116.7 10133.9 10241.4 10310.3 10489.3 23258.9 23266.9 23315.4 23315.7 23333.3 7733.2 7850.8 7890.7 7898.7 8065.9 4142.9 4246.8 4249.2 4303.4 4494.8 3770.8 3822.9 3826.8 3829.0 3831.2 682.7 687.3 701.0 703.8 709.9 605.6 616.5 642.8 644.3 666.0 8190.3 8537.8 8611.0 8617.4 8696.6 608.4 620.0 625.8 629.6 640.0 3836.8 3866.8 3905.5 3979.3 4172.3 71729.3 93192.5 96114.5 96378.0 99256.0 78102.6 79736.2 82349.0 83311.6 83605.6 72304.9 72769.0 73416.6 73777.6 73794.5 7958.6 7962.6 8069.8 8121.7 8467.3 49405.8 50234.5 50471.0 51469.7 51543.7 66968.3 68744.0 69537.7 72274.0 73046.0 11196.1 11213.2 11277.7 11313.8 11545.5 12124.9 12171.4 12290.4 12332.8 12755.6 11627.5 11640.9 11817.2 12131.9 12246.6 11405.4 11775.9 11795.7 11802.7 11822.1 10529.7 10682.1 10694.5 10835.3 10939.7 8950.9 9059.0 9706.5 9982.4 10062.9 9775.8 9799.2 9927.9 9984.8 10085.1 01:59:53 INFO - PROCESS | 1688 | -------- Summary: end -------- 01:59:53 INFO - PROCESS | 1688 | 01:59:54 INFO - TEST-INFO | 1688: exit 0 01:59:54 INFO - TEST-OK | dromaeo_css | took 1113712ms 01:59:54 INFO - TEST-START | kraken 01:59:54 INFO - operating with platform_type : mac_ 01:59:54 INFO - Initialising browser for kraken test... 01:59:54 INFO - TEST-INFO | started process 1806 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpipxmrF/profile http://localhost:49275/getInfo.html) 01:59:56 INFO - PROCESS | 1806 | __metrics Screen width/height:1600/1200 01:59:56 INFO - PROCESS | 1806 | colorDepth:24 01:59:56 INFO - PROCESS | 1806 | Browser inner width/height: 1024/689 01:59:56 INFO - PROCESS | 1806 | __metrics 01:59:56 INFO - PROCESS | 1806 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:59:56 ERROR - PROCESS | 1806 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:59:56 INFO - TEST-INFO | 1806: exit 0 01:59:56 INFO - Browser initialized. 01:59:56 INFO - Running cycle 1/1 for kraken test... 01:59:56 INFO - TEST-INFO | started process 1810 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpipxmrF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:00:08 INFO - PROCESS | 1810 | RSS: Main: 161320960 02:00:08 INFO - PROCESS | 1810 | 02:00:11 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 02:00:12 INFO - PROCESS | 1810 | RSS: Main: 223887360 02:00:12 INFO - PROCESS | 1810 | 02:00:14 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 02:00:15 INFO - PROCESS | 1810 | RSS: Main: 239325184 02:00:15 INFO - PROCESS | 1810 | 02:00:18 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 02:00:19 INFO - PROCESS | 1810 | RSS: Main: 324845568 02:00:19 INFO - PROCESS | 1810 | 02:00:21 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 02:00:21 INFO - PROCESS | 1810 | RSS: Main: 230641664 02:00:21 INFO - PROCESS | 1810 | 02:00:23 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:00:24 INFO - PROCESS | 1810 | RSS: Main: 232095744 02:00:24 INFO - PROCESS | 1810 | 02:00:27 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 02:00:27 INFO - PROCESS | 1810 | RSS: Main: 270106624 02:00:27 INFO - PROCESS | 1810 | 02:00:30 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 02:00:31 INFO - PROCESS | 1810 | RSS: Main: 270123008 02:00:31 INFO - PROCESS | 1810 | 02:00:34 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 02:00:34 INFO - PROCESS | 1810 | RSS: Main: 268034048 02:00:34 INFO - PROCESS | 1810 | 02:00:36 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:00:36 INFO - PROCESS | 1810 | RSS: Main: 260595712 02:00:36 INFO - PROCESS | 1810 | 02:00:38 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:00:39 INFO - PROCESS | 1810 | RSS: Main: 268066816 02:00:39 INFO - PROCESS | 1810 | 02:00:41 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:00:42 INFO - PROCESS | 1810 | RSS: Main: 270712832 02:00:42 INFO - PROCESS | 1810 | 02:00:44 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:00:45 INFO - PROCESS | 1810 | RSS: Main: 277811200 02:00:45 INFO - PROCESS | 1810 | 02:00:48 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:00:49 INFO - PROCESS | 1810 | RSS: Main: 274714624 02:00:49 INFO - PROCESS | 1810 | 02:00:50 INFO - PROCESS | 1810 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 02:00:51 INFO - PROCESS | 1810 | RSS: Main: 335757312 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | __start_tp_report 02:00:51 INFO - PROCESS | 1810 | _x_x_mozilla_page_load 02:00:51 INFO - PROCESS | 1810 | _x_x_mozilla_page_load_details 02:00:51 INFO - PROCESS | 1810 | |i|pagename|runs| 02:00:51 INFO - PROCESS | 1810 | |0;ai-astar;119;163;170;111;112;110;112;112;111;132 02:00:51 INFO - PROCESS | 1810 | |1;audio-beat-detection;151;119;139;162;118;139;118;151;152;116 02:00:51 INFO - PROCESS | 1810 | |2;audio-dft;185;187;184;182;184;182;181;182;183;184 02:00:51 INFO - PROCESS | 1810 | |3;audio-fft;69;80;73;153;56;55;56;61;129;56 02:00:51 INFO - PROCESS | 1810 | |4;audio-oscillator;91;90;141;76;79;77;124;79;77;127 02:00:51 INFO - PROCESS | 1810 | |5;imaging-gaussian-blur;87;84;86;84;86;83;87;86;86;84 02:00:51 INFO - PROCESS | 1810 | |6;imaging-darkroom;92;91;92;93;92;92;92;92;92;100 02:00:51 INFO - PROCESS | 1810 | |7;imaging-desaturate;86;82;83;85;84;79;73;131;132;134 02:00:51 INFO - PROCESS | 1810 | |8;json-parse-financial;59;63;64;61;62;62;61;75;57;56 02:00:51 INFO - PROCESS | 1810 | |9;json-stringify-tinderbox;59;67;90;106;99;71;65;65;65;66 02:00:51 INFO - PROCESS | 1810 | |10;stanford-crypto-aes;81;80;78;79;78;78;79;77;80;70 02:00:51 INFO - PROCESS | 1810 | |11;stanford-crypto-ccm;127;127;140;144;121;147;139;142;162;141 02:00:51 INFO - PROCESS | 1810 | |12;stanford-crypto-pbkdf2;163;168;167;222;207;163;162;162;163;161 02:00:51 INFO - PROCESS | 1810 | |13;stanford-crypto-sha256-iterative;66;65;68;66;65;65;68;67;65;67 02:00:51 INFO - PROCESS | 1810 | __end_tp_report 02:00:51 INFO - PROCESS | 1810 | __start_cc_report 02:00:51 INFO - PROCESS | 1810 | _x_x_mozilla_cycle_collect,1946 02:00:51 INFO - PROCESS | 1810 | __end_cc_report 02:00:51 INFO - PROCESS | 1810 | __startTimestamp1465290051037__endTimestamp 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | ------- Summary: start ------- 02:00:51 INFO - PROCESS | 1810 | Number of tests: 14 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#0] ai-astar Cycles:10 Average:125.20 Median:115.50 stddev:22.80 (19.7%) stddev-sans-first:24.07 02:00:51 INFO - PROCESS | 1810 | Values: 119.0 163.0 170.0 111.0 112.0 110.0 112.0 112.0 111.0 132.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:145.00 stddev:17.43 (12.0%) stddev-sans-first:17.68 02:00:51 INFO - PROCESS | 1810 | Values: 151.0 119.0 139.0 162.0 118.0 139.0 118.0 151.0 152.0 116.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.78 (1.0%) stddev-sans-first:1.79 02:00:51 INFO - PROCESS | 1810 | Values: 185.0 187.0 184.0 182.0 184.0 182.0 181.0 182.0 183.0 184.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#3] audio-fft Cycles:10 Average:78.80 Median:58.50 stddev:34.32 (58.7%) stddev-sans-first:36.22 02:00:51 INFO - PROCESS | 1810 | Values: 69.0 80.0 73.0 153.0 56.0 55.0 56.0 61.0 129.0 56.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:78.00 stddev:24.79 (31.8%) stddev-sans-first:26.22 02:00:51 INFO - PROCESS | 1810 | Values: 91.0 90.0 141.0 76.0 79.0 77.0 124.0 79.0 77.0 127.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:86.00 stddev:1.42 (1.6%) stddev-sans-first:1.36 02:00:51 INFO - PROCESS | 1810 | Values: 87.0 84.0 86.0 84.0 86.0 83.0 87.0 86.0 86.0 84.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:92.00 stddev:2.57 (2.8%) stddev-sans-first:2.71 02:00:51 INFO - PROCESS | 1810 | Values: 92.0 91.0 92.0 93.0 92.0 92.0 92.0 92.0 92.0 100.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:82.50 stddev:24.73 (30.0%) stddev-sans-first:25.92 02:00:51 INFO - PROCESS | 1810 | Values: 86.0 82.0 83.0 85.0 84.0 79.0 73.0 131.0 132.0 134.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:5.23 (8.4%) stddev-sans-first:5.43 02:00:51 INFO - PROCESS | 1810 | Values: 59.0 63.0 64.0 61.0 62.0 62.0 61.0 75.0 57.0 56.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#9] json-stringify-tinderbox Cycles:10 Average:75.30 Median:66.50 stddev:16.59 (25.0%) stddev-sans-first:16.52 02:00:51 INFO - PROCESS | 1810 | Values: 59.0 67.0 90.0 106.0 99.0 71.0 65.0 65.0 65.0 66.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:79.00 stddev:3.06 (3.9%) stddev-sans-first:3.04 02:00:51 INFO - PROCESS | 1810 | Values: 81.0 80.0 78.0 79.0 78.0 78.0 79.0 77.0 80.0 70.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:141.50 stddev:11.76 (8.3%) stddev-sans-first:11.64 02:00:51 INFO - PROCESS | 1810 | Values: 127.0 127.0 140.0 144.0 121.0 147.0 139.0 142.0 162.0 141.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:165.00 stddev:21.85 (13.2%) stddev-sans-first:22.83 02:00:51 INFO - PROCESS | 1810 | Values: 163.0 168.0 167.0 222.0 207.0 163.0 162.0 162.0 163.0 161.0 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - PROCESS | 1810 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.23 (1.8%) stddev-sans-first:1.30 02:00:51 INFO - PROCESS | 1810 | Values: 66.0 65.0 68.0 66.0 65.0 65.0 68.0 67.0 65.0 67.0 02:00:51 INFO - PROCESS | 1810 | -------- Summary: end -------- 02:00:51 INFO - PROCESS | 1810 | 02:00:51 INFO - TEST-INFO | 1810: exit 0 02:00:51 INFO - TEST-OK | kraken | took 57734ms 02:00:51 INFO - SUITE-END | took 1171s 02:00:52 INFO - Completed test suite (00:19:31) 02:00:52 INFO - javascript benchmark 02:00:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3468.23698786267, 3547.5920269169055, 3549.6627820357066, 3552.4671299305087, 3613.187032917592, 5895.646261224319, 5939.64362138272, 5954.612950158236, 5962.672053037081, 5969.044952807551, 5890.263717035371, 5947.226860508139, 5950.196723442334, 5952.642841429517, 5971.4625683688455, 4375.781210939456, 5230.686158830464, 5305.151175811861, 5336.332958380202, 5387.515123638872, 5316.043112239795, 5368.597355198356, 5373.919391209115, 5395.460453954593, 5403.918941215865, 5248.658837175591, 5320.547753440943, 5341.866453338678, 5361.571074314045, 5371.785128594852, 5334.03987282289, 5343.278657381243, 5361.142217245261, 5379.462053794628, 5386.91919621206, 4395.78021098947, 5122.667026643294, 5259.105951988171, 5301.893962120775, 5304.787808487656, 5612.989661860864, 5674.404187560329, 5680.289963754531, 5712.971435142839, 5739.713014349266, 6251.562390632657, 6264.937350626481, 6269.561130720851, 6283.340249273806, 6286.057091436275, 5534.916976245359, 6213.161223234851, 6259.467945224661, 6261.373862613747, 6272.905906411407, 5869.530437564985, 5907.940920590739, 5983.670898100646, 5985.700714964234, 5994.520438364964, 5391.784328626811, 6319.842003949938, 6365.172527571386, 6372.968135159294, 6376.808695739135, 6078.149059131725, 6180.5673602848265, 6249.812505624747, 6256.906146407808, 6262.624242545462, 6270.0908368287255, 6281.309056003836, 6282.748690052438, 6318.778842740482, 6402.807915762534, 6275.529335299871, 6290.24517057956, 6306.968465157736, 6313.305536390993, 6322.652254126067, 6161.014237721943, 6227.9377206227355, 6292.905606415908, 6294.559380843389, 6304.0, 4955.554000139932, 4982.975085124551, 4992.076465853756, 5000.724960127155, 5043.36957880265, 4495.88760280989, 4501.099780044005, 4504.887377815516, 4510.977445112753, 4544.182047231464, 4950.851474455772, 5953.851153721105, 5955.434233747787, 5957.0, 5958.285005799332, 6214.1921550198185, 6247.750089996349, 6255.374462553708, 6258.123862659231, 6260.092286618415, 5922.0, 5937.643741375531, 5941.55438342126, 5953.077273022688, 6069.846729121453, 4247.384129301234, 5453.7818487260065, 5525.475079867406, 5538.806141785099, 5551.916721249185, 6253.1245625612455, 6360.713767880549, 6452.322506136788, 6453.612783233021, 6476.287608363076, 6190.7523699051535, 6198.535109866688, 6253.687315634291, 6255.186825712628, 6266.342034086538, 6432.00303952888, 6435.517336199898, 6459.095726598186, 6459.354064593503, 6469.191351081115, 6139.584134579286, 6200.100985357189, 6234.438900498977, 6283.622982621057, 6303.653299068412, 6262.34245404226, 6272.247330320391, 6285.120083188449, 6285.1515045470105, 6295.0, 5245.501677340799, 6179.907301390573, 6261.060840873905, 6272.874542509216, 6279.560430769802, 5907.379725128972, 6141.608749743955, 6143.112737013596, 6208.1308616792785, 6244.344343843831, 6099.993501072451, 6104.969475152596, 6133.969330153321, 6138.662373569497, 6158.876822463615, 6228.408301211378, 6232.501399887908, 6246.094316324016, 6248.656323902229, 6253.187085678833, 6011.428914253139, 6067.211262536019, 6148.631082135086, 6150.569460137747, 6167.167432396748], "value": 5777.0272803532935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.0990700483694, 562.3139769481234, 574.43131300013, 575.8122743682311, 578.3926876779382, 34262.314753704944, 39720.42516173544, 40619.9845003875, 40659.39010914831, 40977.59022409775, 46231.84420389492, 46472.3029154563, 46602.53397466024, 46611.53388466114, 46687.766561167235, 9036.367454278203, 9897.653582124627, 10094.697159085203, 10108.44403557804, 11662.941685291562, 11839.467223974942, 11966.940165299162, 11969.341686207255, 11971.7605647887, 11976.880231197707, 11913.94043029788, 11973.0, 11980.34108124053, 12000.51997920082, 12096.33470159141, 8204.630791614392, 9295.256379489658, 9515.191208747265, 9517.666881659108, 11909.880901190963, 11868.703282418008, 12169.330686812222, 12172.330521821295, 12181.33002684852, 12184.329861857594, 40820.77537673845, 41250.79374603138, 41300.0, 41369.79315103405, 41611.0, 3361.210115622827, 3368.59576850777, 3478.113081164312, 3617.439296908983, 3653.4702468142236, 27917.720822791714, 27968.86015569909, 28068.859655701795, 28309.43381132366, 29028.27429314263, 2670.0254407141447, 2670.425858440425, 2685.717999610032, 2761.0336382266046, 2776.5141100307364, 450797.0, 450855.0, 451451.0, 451740.0, 452324.0, 63125.73748525095, 63176.0, 63786.36213637897, 63951.0, 64716.676416617614, 71254.64372678207, 71551.0, 71682.20794480076, 71804.64097679478, 71905.64047179835, 18406.447806565557, 19072.90463547701, 19077.618447630968, 19083.522911927033, 19092.713609295595, 13185.73628527424, 13468.461261549624, 14416.990810643365, 14798.704025919636, 14808.62978425548, 18816.47420330068, 19344.613107737765, 19681.704774428108, 20150.0, 20876.686849697267, 7172.677229524684, 7563.73526926566, 8430.48251314757, 8454.239118479367, 8466.280366168945, 970.427447805798, 1040.47976011994, 1046.7173863057085, 1129.4522156753967, 1133.3539882267028, 30448.0, 30877.8456107718, 30934.22664433407, 31389.843050785057, 31474.527882081788, 1164.8875324065498, 1234.4383305596111, 1235.9011279097651, 1236.258245052979, 1301.44688507384, 13231.404586793617, 15538.922305388627, 15823.604409889615, 15910.363585456684, 16275.918620406823, 618880.0, 624339.0, 628161.0, 633860.0, 633924.0, 51214.74392628013, 63534.0, 63659.363406365344, 63762.0, 64115.0, 1278.878506541877, 1426.771716525351, 1501.4144483651603, 1576.9211539422984, 1588.3884704388663, 26334.34164145835, 29294.41411171722, 30588.08235752931, 30870.073897783102, 31239.219019524695, 39465.60534394619, 43100.56899431091, 51830.222546661076, 52289.0, 52318.47681523136, 445984.0, 447198.0, 447626.0, 449334.0, 449509.0, 23943.760562394153, 23988.920498577256, 25401.364965876, 28481.145565633065, 28539.714602853706, 45102.77448612736, 45221.095578087596, 45475.77262113668, 46933.06133877235, 47214.76392618015, 36265.09337266589, 37434.62565374311, 37577.872663820126, 38153.61846381501, 38454.2309153821, 29172.708272917, 32695.836520817244, 34254.82872585621, 37072.81463592665, 37775.0, 37405.87782366533, 38065.4290185653, 38742.03144921287, 38771.0, 39043.804780975915, 32252.677473225907, 33936.66063339335, 33981.0, 34029.65970340265, 34055.0, 25418.745812541638, 25686.61470077913, 25724.39353099668, 25836.8708156458, 26237.737622624292], "value": 20598.971713658, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.62270804301465, 416.5189206466528, 418.9643880270175, 423.881313232295, 438.064731797612, 14934.0, 20428.28501002465, 21172.364829055135, 21177.894110529443, 21511.892440537777, 21177.364679059614, 21482.570348593057, 22288.442788930286, 22517.774822251773, 22528.0, 4776.665633405654, 5889.146073819294, 6193.234928045508, 6194.876102477948, 6203.2245969253845, 5868.735906884179, 6111.816645500619, 6147.754089836423, 6179.258488981306, 6216.067589861512, 6187.814365569017, 6209.658468784215, 6217.347178546255, 6224.284207316148, 6228.719707613146, 5843.094320380326, 6175.07373893915, 6179.0422484514975, 6185.628862268279, 6199.907001394983, 5732.484076433099, 5995.700214989277, 6035.879282414371, 6040.848978775522, 6070.635761854259, 14187.929060354736, 14240.572782816533, 14402.855971440256, 14498.637534061627, 14564.0, 2289.0843662534953, 2377.3937645900187, 2385.85684858909, 2598.363400966756, 2639.0499420208707, 9966.352187107886, 10037.0, 10057.849132263022, 10480.266381353309, 10495.370277783357, 1798.5413719501444, 1804.7653805005395, 1832.221305944968, 1850.8796928199758, 1927.0557426860737, 93935.06064939332, 121427.0, 121850.0, 121852.17221741681, 127159.0, 11843.460350154424, 12003.759924801456, 12047.819282710767, 12192.390380481118, 12313.537292541349, 14259.287035648176, 14848.62878428048, 15118.546443606709, 15816.525504234662, 15859.682806344039, 9122.589483473259, 9274.258059355236, 9398.812023759623, 9406.623735050658, 9469.715908522756, 9427.717168484956, 9462.243020558339, 9479.431234125974, 9555.0, 9567.61729530811, 4308.1814455254025, 4487.057717879216, 4733.786979585927, 4806.447258565309, 4837.419509658864, 1831.5238038110188, 1964.145596665455, 1978.4262563856607, 2040.795920407977, 2053.219776484926, 936.5317341329335, 979.397670432693, 1024.3444195714749, 1047.1151876664208, 1080.0, 17754.289828406978, 20682.0, 21401.571968560853, 21651.312011584712, 21691.45771355697, 1005.2962925951863, 1014.6803756816579, 1015.6292953072076, 1085.9294145880492, 1110.1119104716195, 10899.727506812393, 11456.369899655432, 11491.138164637685, 11492.023178029962, 11509.827352589718, 630739.0, 647782.0, 648264.0, 648909.0, 669772.0, 132302.0, 132317.0, 135909.87920254722, 137243.0, 139412.0, 1025.553884060436, 1027.7893031928586, 1035.249444152983, 1044.2272718188485, 1068.1188019883782, 18744.7188292173, 18867.90566047161, 19014.144363503397, 19018.0, 19296.0, 40938.795306023276, 49797.75101124471, 51480.45558633247, 54033.378998630105, 57609.711951439975, 67683.66158169178, 70002.64998674973, 70649.0, 70789.0, 72311.27688723255, 8119.4722343047515, 8349.791255218668, 8506.106858779738, 8514.91485085166, 8522.74431767048, 9440.763980900532, 12788.616341509769, 12931.870681293443, 13078.411471483996, 13363.866361336262, 11159.072741806685, 11311.943440282746, 11324.773504530029, 11340.09279257641, 11739.471723772622, 10956.506957186786, 11163.0, 11174.608888688857, 11490.77018459643, 11680.007199388147, 9349.719508414759, 11371.488283027118, 11488.425578721197, 11509.079273658255, 11907.16649834538, 8212.794680133044, 8279.213474719892, 8355.874661880198, 8392.328613710766, 8533.0, 8546.145385461405, 10867.021968022917, 11138.94430527842, 11245.044171245536, 11452.599159029394], "value": 9708.209117258479, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.9447622095117, 1483.3992233145566, 1607.863331616813, 1830.4874635102176, 2012.8691635043713, 8287.088420273772, 8940.642374305027, 9048.230900373459, 9079.591418386171, 9135.223506001981, 8474.449160804543, 8740.606672699729, 8745.475271483716, 8749.562521873913, 8792.8681069784, 2515.383730985911, 2547.7070136934212, 2549.655796467481, 2552.0940066276485, 2553.2595547291357, 2469.925902222927, 2533.5946248600226, 2535.2394281715506, 2536.7843733282693, 2540.530001949636, 2509.2848538166627, 2532.5441420544294, 2549.7450254974447, 2557.56521391363, 2560.6927168739685, 2121.7241758571363, 2129.776373480793, 2494.9376265593323, 2522.495500899818, 2546.2997675639162, 2483.4784695214025, 2514.7610976957158, 2523.5079159563893, 2527.873606319695, 2538.504991526653, 8750.47497150173, 8812.427192232484, 8876.334274929342, 8886.955565222133, 8982.505962172077, 5597.916031259534, 5837.270341207349, 5852.707364631751, 5862.208601838783, 5866.648001119904, 3603.94594081089, 3663.853445862189, 3721.0325315417917, 3727.4408838674144, 3741.8690345837763, 1031.4481752262504, 1034.6223628375665, 1043.3218408034763, 1053.9420331881743, 1068.2415485005656, 12111.849374309426, 12334.75330493394, 12354.196977196454, 12364.505419783198, 12367.62897113088, 4747.311639812277, 4768.642351823558, 4786.114568804782, 4802.056757848273, 4845.127876982177, 9511.952440237754, 9519.476428796483, 9547.188488978376, 9550.474723890253, 9587.18508926749, 5562.110062390079, 5567.49892509668, 5568.081266591048, 5568.9443105568425, 5575.860603484945, 4549.727016379028, 4626.190416677068, 4791.832285869978, 4863.10032643962, 5181.326427564468, 3950.802459876995, 3983.701222408273, 4044.9595504045174, 4062.614051665087, 4076.5311989121633, 1254.5295514182183, 1272.4846437192953, 1276.463885168213, 1280.180684362009, 1288.3043156695467, 874.8381549413378, 971.8095333216894, 985.2659768472533, 987.4223579206244, 1027.2254481693221, 6067.484263837623, 6092.0, 6164.47601953839, 6275.341089185661, 6299.055141728686, 467.9836205732851, 480.4186933810059, 489.20015774209423, 496.5803895708121, 496.7913476339946, 3420.743444241692, 4060.4721386219603, 4097.242010228118, 4099.8360065597635, 4129.442525259112, 10931.234813563133, 11435.199536032398, 11481.598144064918, 11486.597969071043, 11487.0, 10347.379157250589, 10662.466876656135, 10797.46012699362, 10802.567897284178, 10812.243142980073, 8335.541545215072, 8364.0, 8532.402731808714, 8567.74296771098, 8609.65561377538, 5162.819301324435, 5836.270466191726, 6017.608855424383, 6067.605605635619, 6262.68686565679, 9609.135177834029, 9872.35829671069, 9890.406575605486, 9945.950270248602, 10031.54858031405, 9744.658936937172, 10295.176385889261, 10306.948465257925, 10494.842577361498, 10518.053375196268, 6913.204981426999, 7608.353289970193, 7832.647530861239, 8130.959345203236, 8669.523176225115, 8460.57697115154, 8462.492250464991, 8525.786855328666, 8533.957330213309, 8561.44350617208, 7385.7045718170675, 7540.132884718328, 7591.089069311718, 7603.923960760543, 7661.540307581563, 7369.042024536776, 7417.443691723251, 7422.888656670262, 7503.962480187564, 7527.661255243418, 7175.856482870209, 7222.458315626244, 7239.660662777403, 7245.601491917995, 7306.2693730626515, 4941.555260026471, 5014.548690617862, 5060.544550990428, 5132.769025393941, 5167.1474206755465, 5079.898402032012, 5097.235414687826, 5114.9232761507865, 5176.7152806596, 5356.625036247426], "value": 4636.951865357185, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.8931829200635, 338.6156712131731, 340.97783644063134, 349.50544978854913, 353.8814497143457, 6752.493562982771, 6753.763618273361, 6767.966160169199, 6768.3908448239645, 6867.484938629598, 5407.0, 5670.716464176785, 6763.086983257259, 6778.220504641968, 6801.591904485735, 4195.7063005589625, 4302.591253830897, 4570.97714511427, 4700.506446823086, 5000.7249601271915, 4092.815823287944, 4947.183714687072, 5010.624203184758, 5013.398392192942, 5017.569992552123, 4942.629302802305, 4954.653174277802, 4961.950380496203, 4973.378327709036, 4984.675996060263, 4330.614203454896, 4765.761711914408, 4839.830605928793, 4974.552290293855, 4987.900241995139, 4064.593540645941, 4230.2174097792, 4260.8721738347895, 4262.318029115327, 4284.485861696617, 6446.677666116675, 6462.547621666486, 6466.935330646727, 6546.116274303004, 6557.311482294386, 5924.4667979882015, 5950.880982380371, 5954.136650185742, 5959.0, 5964.552658550626, 6584.979328204136, 6900.585964842126, 6910.412614927737, 7243.058402407653, 7250.891236631454, 4627.930581041287, 4647.55848194421, 4668.813247470097, 4687.460941991681, 4693.647976401783, 7563.810904727371, 7649.388048956126, 7650.19672934345, 7669.501482403682, 7710.689182838931, 4730.148573256778, 4745.738984355825, 4747.738874361874, 4749.24012158053, 4760.119377915097, 4801.903961920742, 4820.156472617348, 4822.204336284544, 4822.68652537584, 4824.807007719652, 5527.419620939824, 5773.971130144407, 5780.508656764222, 5784.82645520635, 5800.8259752207505, 6124.938750612437, 6898.0, 7163.570185788869, 7208.27917208275, 7226.060612120391, 1641.8686505079565, 1675.7850558345103, 1685.6207353345399, 1686.8481836634762, 1688.3921788156254, 880.5553195636163, 1000.6541202083187, 1010.525053224983, 1048.7535429174138, 1072.8176210044312, 5639.548836093103, 6735.8989615155815, 6864.691088901011, 6872.041468181545, 6891.689873955684, 7547.660355284025, 7549.698012079455, 7559.130699969464, 7574.545527268381, 7581.203973582805, 6847.897281540781, 6853.314668533207, 6855.897161542581, 6868.725250989904, 6881.724731010803, 3829.5404551454003, 3950.9849976512187, 4001.919961600752, 4002.0, 4009.799510024487, 7875.921240787518, 7912.881306780288, 7949.602519874099, 7951.721689740832, 7963.203679632106, 7744.380449564022, 7811.687532498637, 7815.179406162385, 7827.060752709711, 7830.138684744674, 6291.213598300213, 7883.448158628956, 7902.288794008567, 7902.723404680809, 7912.169222231698, 7221.169565500035, 7507.737229196952, 7513.323800857949, 7520.924790752022, 7527.623618819147, 6926.653667316715, 7424.777256682308, 7441.92558074434, 7450.366718828744, 7457.6271186441545, 6721.932780672326, 7865.134835168242, 7894.644740986554, 7897.012873390826, 7898.328642065489, 4729.290606409066, 4730.810767569259, 4744.928826067543, 4747.0, 4752.596029337406, 7247.818804529718, 7489.475736698379, 7502.0, 7522.360599348897, 7541.698332066656, 6357.078223657451, 6892.0, 7242.601656908921, 7270.636468176464, 7272.200057993511, 7216.0258365120035, 7223.386012189023, 7252.673629686571, 7258.673359698721, 7260.709571617076, 7086.964565177141, 7098.538594991309, 7108.822279443055, 7112.288771122846, 7120.0, 6972.163340399185, 7247.202807691045, 7272.745453909088, 7281.490295679251, 7282.3809976152625, 6862.519623626298, 7011.719531218694, 7060.823479413056, 7152.9270609409, 7203.423726101794], "value": 5243.029649881467, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.4841739738694, 719.4855678190092, 727.127447063524, 727.2182403915789, 736.3630459652401, 15237.314320855561, 15465.536033918972, 15486.303116359762, 15491.535253942371, 15513.0, 14160.858391416108, 14248.715025699506, 14315.498957536489, 14318.92840535796, 14327.426902923871, 669.5848573884186, 788.2590365056828, 797.9880301795478, 939.6992962252082, 966.0387914025555, 972.8054389122168, 973.7127547373542, 975.1759763000254, 975.5707488704948, 978.1538968791979, 1020.9948950255239, 1035.8549803027581, 1038.6624347087227, 1040.2042437535292, 1040.8438734189895, 832.4672209785742, 1000.2498126405196, 1025.96409125681, 1030.9896901030968, 1031.6904928521415, 767.0182166826471, 769.2154002917049, 770.730244414456, 770.8843673449028, 771.1902502372486, 15352.462663806826, 15406.075635461908, 15406.922965385213, 15410.460633877761, 15516.0, 12387.814182787266, 12847.0, 13032.86967130326, 13223.074384793068, 13223.999999999904, 11074.335539867634, 11377.715557111138, 11421.657350279505, 11636.069114470822, 11654.125940554492, 3094.6131733533307, 3588.4617307403837, 3608.855645774166, 3636.6181550937035, 3822.73240873139, 73676.6316168421, 74807.0, 76565.61717191435, 77271.613641932, 90052.19895602117, 10116.696499105039, 10133.898661013443, 10241.43672098027, 10310.278280520291, 10489.265751397481, 23258.883705581364, 23266.883665581903, 23315.417114572272, 23315.650265246033, 23333.300000999996, 7733.226677332222, 7850.764477065697, 7890.723824666109, 7898.684052637945, 8065.879011814827, 4142.855000074983, 4246.8301267949555, 4249.192653395845, 4303.354496825438, 4494.775261236925, 3770.811459427018, 3822.9235415292096, 3826.7895265760094, 3828.980855095707, 3831.214601006787, 682.6757290287073, 687.3435868745336, 700.9824754381182, 703.7607213547418, 709.9432045436353, 605.5518916002214, 616.5499185594541, 642.8232236135007, 644.2591020326662, 666.0275997044273, 8190.344772418192, 8537.786555336043, 8611.0, 8617.396782225183, 8696.608652610521, 608.4341562347059, 620.0203678188451, 625.7653379982506, 629.6064959400375, 639.990400143989, 3836.7506112102624, 3866.7873266970587, 3905.511811023622, 3979.2837289287627, 4172.311568591149, 71729.2827071733, 93192.53403732937, 96114.51942740241, 96378.0, 99256.01487970201, 78102.6094869522, 79736.20263797404, 82349.0, 83311.5834420824, 83605.58197208976, 72304.91542626865, 72769.0, 73416.63291683508, 73777.6311118441, 73794.52410951858, 7958.562279074707, 7962.601869906365, 8069.798255043436, 8121.715739949073, 8467.322614190727, 49405.75297123491, 50234.49765502445, 50471.0, 51469.742651286506, 51543.74228128985, 66968.32579185559, 68744.0, 69537.65231173811, 72274.0, 73046.0, 11196.104311655212, 11213.159013074215, 11277.661670149908, 11313.830292545454, 11545.48045337945, 12124.93937530342, 12171.39143042862, 12290.385480726107, 12332.753344933231, 12755.61733148007, 11627.476763545492, 11640.94179529097, 11817.172797904408, 12131.939340303243, 12246.632601021984, 11405.429728513707, 11775.941120294343, 11795.705107372385, 11802.704932376759, 11822.054235661299, 10529.736756581147, 10682.092022178202, 10694.465276736288, 10835.349879007284, 10939.726506837393, 8950.881139857518, 9058.954705226432, 9706.466144362128, 9982.401055936667, 10062.949685251528, 9775.755606109904, 9799.216062715108, 9927.900720992986, 9984.750381240527, 10085.142762865238], "value": 7154.275131985762, "unit": "score"}], "name": "dromaeo_css", "value": 7653.343772503568, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 163.0, 170.0, 111.0, 112.0, 110.0, 112.0, 112.0, 111.0, 132.0], "value": 125.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 119.0, 139.0, 162.0, 118.0, 139.0, 118.0, 151.0, 152.0, 116.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 184.0, 182.0, 184.0, 182.0, 181.0, 182.0, 183.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 73.0, 153.0, 56.0, 55.0, 56.0, 61.0, 129.0, 56.0], "value": 78.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 141.0, 76.0, 79.0, 77.0, 124.0, 79.0, 77.0, 127.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 84.0, 86.0, 83.0, 87.0, 86.0, 86.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 92.0, 93.0, 92.0, 92.0, 92.0, 92.0, 92.0, 100.0], "value": 92.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 83.0, 85.0, 84.0, 79.0, 73.0, 131.0, 132.0, 134.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 64.0, 61.0, 62.0, 62.0, 61.0, 75.0, 57.0, 56.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 67.0, 90.0, 106.0, 99.0, 71.0, 65.0, 65.0, 65.0, 66.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 78.0, 79.0, 78.0, 78.0, 79.0, 77.0, 80.0, 70.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 140.0, 144.0, 121.0, 147.0, 139.0, 142.0, 162.0, 141.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 167.0, 222.0, 207.0, 163.0, 162.0, 162.0, 163.0, 161.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 68.0, 66.0, 65.0, 65.0, 68.0, 67.0, 65.0, 67.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1489.3, "alertThreshold": 2.0}]} 02:00:52 INFO - Return code: 0 02:00:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:00:52 ERROR - # TBPL SUCCESS # 02:00:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:00:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:00:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:00:52 INFO - 2016-06-07 02:00:52.367 screenresolution[1819:9861] starting screenresolution argv=screenresolution get 02:00:52 INFO - 2016-06-07 02:00:52.370 screenresolution[1819:9861] Display 0: 1600x1200x32@60 02:00:52 INFO - 2016-06-07 02:00:52.376 screenresolution[1820:9864] starting screenresolution argv=screenresolution list 02:00:52 INFO - Available Modes on Display 0 02:00:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:00:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:00:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:00:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:00:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:00:52 INFO - Intel Iris: 02:00:52 INFO - Chipset Model: Intel Iris 02:00:52 INFO - Type: GPU 02:00:52 INFO - Bus: Built-In 02:00:52 INFO - VRAM (Dynamic, Max): 1536 MB 02:00:52 INFO - Vendor: Intel (0x8086) 02:00:52 INFO - Device ID: 0x0a2e 02:00:52 INFO - Revision ID: 0x0009 02:00:52 INFO - Displays: 02:00:52 INFO - Display: 02:00:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:00:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:00:52 INFO - Display Serial Number: 1600x1200 60 02:00:52 INFO - Main Display: Yes 02:00:52 INFO - Mirror: Off 02:00:52 INFO - Online: Yes 02:00:52 INFO - Rotation: Supported 02:00:52 INFO - Return code: 0 02:00:52 INFO - Running post-action listener: _resource_record_post_action 02:00:52 INFO - Running post-run listener: _resource_record_post_run 02:00:53 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 36996608; Write bytes: 496359936; Read time: 236; Write time: 1559 02:00:53 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 200083968; Write bytes: 197265408; Read time: 17832; Write time: 429 02:00:53 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 29875712; Write bytes: 298086912; Read time: 179; Write time: 1125 02:00:53 INFO - Running post-run listener: _upload_blobber_files 02:00:53 INFO - Blob upload gear active. 02:00:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:00:53 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 02:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:00:54 INFO - (blobuploader) - INFO - Open directory for files ... 02:00:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:00:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:00:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:00:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:00:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:00:55 INFO - (blobuploader) - INFO - Done attempting. 02:00:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:00:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:00:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:00:56 INFO - (blobuploader) - INFO - Done attempting. 02:00:56 INFO - (blobuploader) - INFO - Iteration through files over. 02:00:56 INFO - Return code: 0 02:00:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:00:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:00:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/022a236638c89235096debf16b03da8b1833d9ebb5ded883edff1dfe51da240d595d8484b46729d776089d4dd544c5de5d2990e3a956ba36b12fe5976cfd6c82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75a5059a9ca0ea4b1f81a4c89865383ec26c00e0976645d88d88f3cc39d98e73583cc0a7eaacf005c96a24e5672e4c27b909f77aab0bf9f7f167091961927d6d"} 02:00:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:00:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:00:56 INFO - Contents: 02:00:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/022a236638c89235096debf16b03da8b1833d9ebb5ded883edff1dfe51da240d595d8484b46729d776089d4dd544c5de5d2990e3a956ba36b12fe5976cfd6c82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75a5059a9ca0ea4b1f81a4c89865383ec26c00e0976645d88d88f3cc39d98e73583cc0a7eaacf005c96a24e5672e4c27b909f77aab0bf9f7f167091961927d6d"} 02:00:56 INFO - Running post-run listener: copy_logs_to_upload_dir 02:00:56 INFO - Copying logs to upload dir... 02:00:56 INFO - mkdir: /builds/slave/test/build/upload/logs 02:00:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.724730 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-07 02:00:56.223734) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:00:56.227369) ========= 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.ntq17foTAs/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.ohcJ90Op8u/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/022a236638c89235096debf16b03da8b1833d9ebb5ded883edff1dfe51da240d595d8484b46729d776089d4dd544c5de5d2990e3a956ba36b12fe5976cfd6c82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75a5059a9ca0ea4b1f81a4c89865383ec26c00e0976645d88d88f3cc39d98e73583cc0a7eaacf005c96a24e5672e4c27b909f77aab0bf9f7f167091961927d6d"} build_url:https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/PxB3FQ5KTfyfEzLrGfqEzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/022a236638c89235096debf16b03da8b1833d9ebb5ded883edff1dfe51da240d595d8484b46729d776089d4dd544c5de5d2990e3a956ba36b12fe5976cfd6c82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75a5059a9ca0ea4b1f81a4c89865383ec26c00e0976645d88d88f3cc39d98e73583cc0a7eaacf005c96a24e5672e4c27b909f77aab0bf9f7f167091961927d6d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:00:56.266128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:00:56.266725) ========= 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.ntq17foTAs/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.ohcJ90Op8u/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005014 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:00:56.317604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:00:56.318147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:00:56.318796) ========= ========= Total master_lag: 0.19 =========