builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0193 starttime: 1461185240.17 results: success (0) buildid: 20160420124052 builduid: 273b70f21fd344da850619ad6714fc0e revision: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 13:47:20.170429) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 13:47:20.170805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 22 secs) (at 2016-04-20 13:47:20.171085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 22 secs) (at 2016-04-20 13:47:42.874899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-20 13:47:42.875153) ========= 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.iXPRj9w0KK/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.aeTlQ028ss/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-20 13:47:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 31.2M=0s 2016-04-20 13:47:43 (31.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.682873 ========= master_lag: 6.65 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-20 13:47:50.212100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 13:47:50.212586) ========= 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.iXPRj9w0KK/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.aeTlQ028ss/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.020772 ========= master_lag: 1.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 13:47:51.429979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-04-20 13:47:51.430307) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2387e00d2ce89a2cd641df7ca92af4feeeebe556 --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-aurora --rev 2387e00d2ce89a2cd641df7ca92af4feeeebe556 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iXPRj9w0KK/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.aeTlQ028ss/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-20 13:47:51,534 truncating revision to first 12 chars 2016-04-20 13:47:51,534 Setting DEBUG logging. 2016-04-20 13:47:51,534 attempt 1/10 2016-04-20 13:47:51,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2387e00d2ce8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 13:47:52,716 unpacking tar archive at: mozilla-aurora-2387e00d2ce8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.427891 ========= master_lag: 5.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-04-20 13:47:58.417330) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 13:47:58.417685) ========= script_repo_revision: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 13:47:58.418076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-04-20 13:47:58.418337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-04-20 13:48:00.566870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-20 13:48:00.567283) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iXPRj9w0KK/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.aeTlQ028ss/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 13:48:00 INFO - MultiFileLogger online at 20160420 13:48:00 in /builds/slave/test 13:48:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:48:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:48:00 INFO - {'append_to_log': False, 13:48:00 INFO - 'base_work_dir': '/builds/slave/test', 13:48:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:48:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:48:00 INFO - 'branch': 'Mozilla-Aurora', 13:48:00 INFO - 'buildbot_json_path': 'buildprops.json', 13:48:00 INFO - 'config_files': ('talos/mac_config.py',), 13:48:00 INFO - 'default_actions': ('clobber', 13:48:00 INFO - 'read-buildbot-config', 13:48:00 INFO - 'download-and-extract', 13:48:00 INFO - 'populate-webroot', 13:48:00 INFO - 'create-virtualenv', 13:48:00 INFO - 'install', 13:48:00 INFO - 'run-tests'), 13:48:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:48:00 INFO - 'download_minidump_stackwalk': True, 13:48:00 INFO - 'download_symbols': 'ondemand', 13:48:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:48:00 INFO - 'tooltool.py': '/tools/tooltool.py', 13:48:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:48:00 INFO - '/tools/misc-python/virtualenv.py')}, 13:48:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:48:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:48:00 INFO - 'installer_path': 'installer.exe', 13:48:00 INFO - 'log_level': 'info', 13:48:00 INFO - 'log_name': 'talos', 13:48:00 INFO - 'log_to_console': True, 13:48:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:48:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:48:00 INFO - 'opt_config_files': (), 13:48:00 INFO - 'pip_index': False, 13:48:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:00 INFO - 'cmd': ('bash', 13:48:00 INFO - '-c', 13:48:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:00 INFO - 'enabled': True, 13:48:00 INFO - 'halt_on_failure': False, 13:48:00 INFO - 'name': 'check_screen_resolution'},), 13:48:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:00 INFO - 'cmd': ('bash', 13:48:00 INFO - '-c', 13:48:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:00 INFO - 'enabled': True, 13:48:00 INFO - 'halt_on_failure': False, 13:48:00 INFO - 'name': 'check_screen_resolution'},), 13:48:00 INFO - 'run_cmd_checks_enabled': True, 13:48:00 INFO - 'sps_profile': False, 13:48:00 INFO - 'sps_profile_interval': 0, 13:48:00 INFO - 'suite': 'dromaeojs-e10s', 13:48:00 INFO - 'system_bits': '32', 13:48:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:48:00 INFO - 'title': 't-yosemite-r7-0193', 13:48:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:48:00 INFO - 'use_talos_json': True, 13:48:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:48:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:48:00 INFO - 'work_dir': 'build'} 13:48:00 INFO - ##### 13:48:00 INFO - ##### Running clobber step. 13:48:00 INFO - ##### 13:48:00 INFO - Running pre-action listener: _resource_record_pre_action 13:48:00 INFO - Running main action method: clobber 13:48:00 INFO - rmtree: /builds/slave/test/build 13:48:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:48:02 INFO - Running post-action listener: _resource_record_post_action 13:48:02 INFO - ##### 13:48:02 INFO - ##### Running read-buildbot-config step. 13:48:02 INFO - ##### 13:48:02 INFO - Running pre-action listener: _resource_record_pre_action 13:48:02 INFO - Running main action method: read_buildbot_config 13:48:02 INFO - Using buildbot properties: 13:48:02 INFO - { 13:48:02 INFO - "project": "", 13:48:02 INFO - "product": "firefox", 13:48:02 INFO - "script_repo_revision": "production", 13:48:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:48:02 INFO - "repository": "", 13:48:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:48:02 INFO - "buildid": "20160420124052", 13:48:02 INFO - "pgo_build": "False", 13:48:02 INFO - "basedir": "/builds/slave/test", 13:48:02 INFO - "buildnumber": 249, 13:48:02 INFO - "slavename": "t-yosemite-r7-0193", 13:48:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:48:02 INFO - "platform": "yosemite_r7", 13:48:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:48:02 INFO - "branch": "mozilla-aurora", 13:48:02 INFO - "repo_path": "releases/mozilla-aurora", 13:48:02 INFO - "revision": "2387e00d2ce89a2cd641df7ca92af4feeeebe556", 13:48:02 INFO - "stage_platform": "macosx64", 13:48:02 INFO - "builduid": "273b70f21fd344da850619ad6714fc0e", 13:48:02 INFO - "slavebuilddir": "test" 13:48:02 INFO - } 13:48:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 13:48:02 INFO - Running post-action listener: _resource_record_post_action 13:48:02 INFO - ##### 13:48:02 INFO - ##### Running download-and-extract step. 13:48:02 INFO - ##### 13:48:02 INFO - Running pre-action listener: _resource_record_pre_action 13:48:02 INFO - Running main action method: download_and_extract 13:48:02 INFO - mkdir: /builds/slave/test/build/tests 13:48: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')]} 13:48:02 INFO - https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:48:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 13:48:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 13:48:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 13:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 13:48:04 INFO - Downloaded 1277 bytes. 13:48:04 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 13:48:04 INFO - Using the following test package requirements: 13:48:04 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:48:04 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:48:04 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 13:48:04 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:48:04 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 13:48:04 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:48:04 INFO - u'jsshell-mac.zip'], 13:48:04 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:48:04 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 13:48:04 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:48:04 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:48:04 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 13:48:04 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:48:04 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 13:48:04 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:48:04 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 13:48:04 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:48:04 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:48:04 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 13:48:04 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:04 INFO - https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:48:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:48:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:48:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:48:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:48:05 INFO - Downloaded 17911980 bytes. 13:48:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:48:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:48:08 INFO - Return code: 0 13:48:08 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:48:08 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')]} 13:48:08 INFO - https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:48:09 INFO - Downloaded 17911980 bytes. 13:48:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:48:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:48:13 INFO - Return code: 0 13:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:13 INFO - https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:48:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:48:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:48:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:48:14 INFO - Downloaded 10845198 bytes. 13:48:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:48:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:48:15 INFO - Return code: 0 13:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:15 INFO - https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 13:48:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:48:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:48:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 13:48:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 13:48:18 INFO - Downloaded 115254335 bytes. 13:48:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:48:18 INFO - mkdir: /builds/slave/test/properties 13:48:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:48:18 INFO - Writing to file /builds/slave/test/properties/build_url 13:48:18 INFO - Contents: 13:48:18 INFO - build_url:https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:48:18 INFO - Running post-action listener: _resource_record_post_action 13:48:18 INFO - Running post-action listener: set_extra_try_arguments 13:48:18 INFO - ##### 13:48:18 INFO - ##### Running populate-webroot step. 13:48:18 INFO - ##### 13:48:18 INFO - Running pre-action listener: _resource_record_pre_action 13:48:18 INFO - Running main action method: populate_webroot 13:48:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:48:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:48:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:48:18 INFO - '--tppagecycles', 13:48:18 INFO - '7'], 13:48:18 INFO - 'tests': ['tsvgm']}}, 13:48:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:48:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:48:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:48:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:48:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:48:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:48:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:18 INFO - 'talos_options': ['--e10s'], 13:48:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:18 INFO - 'tests': ['damp', 'tps']}, 13:48:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:18 INFO - 'talos_options': ['--e10s'], 13:48:18 INFO - 'tests': ['damp', 'tps']}, 13:48:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:48:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:48:18 INFO - 'other': {'tests': ['a11yr', 13:48:18 INFO - 'ts_paint', 13:48:18 INFO - 'tpaint', 13:48:18 INFO - 'sessionrestore', 13:48:18 INFO - 'sessionrestore_no_auto_restore', 13:48:18 INFO - 'tabpaint']}, 13:48:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:48:18 INFO - 'tests': ['a11yr', 13:48:18 INFO - 'ts_paint', 13:48:18 INFO - 'tpaint', 13:48:18 INFO - 'sessionrestore', 13:48:18 INFO - 'sessionrestore_no_auto_restore', 13:48:18 INFO - 'tabpaint']}, 13:48:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:48:18 INFO - 'tests': ['a11yr', 13:48:18 INFO - 'ts_paint', 13:48:18 INFO - 'tpaint', 13:48:18 INFO - 'sessionrestore', 13:48:18 INFO - 'sessionrestore_no_auto_restore', 13:48:18 INFO - 'tabpaint']}, 13:48:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:48:18 INFO - 'tests': ['a11yr', 13:48:18 INFO - 'ts_paint', 13:48:18 INFO - 'tpaint', 13:48:18 INFO - 'sessionrestore', 13:48:18 INFO - 'sessionrestore_no_auto_restore', 13:48:18 INFO - 'tabpaint']}, 13:48:18 INFO - 'other_l64': {'tests': ['a11yr', 13:48:18 INFO - 'ts_paint', 13:48:18 INFO - 'tpaint', 13:48:18 INFO - 'sessionrestore', 13:48:18 INFO - 'sessionrestore_no_auto_restore', 13:48:18 INFO - 'tabpaint']}, 13:48:18 INFO - 'other_nol64': {'tests': ['a11yr', 13:48:18 INFO - 'ts_paint', 13:48:18 INFO - 'tpaint', 13:48:18 INFO - 'sessionrestore', 13:48:18 INFO - 'sessionrestore_no_auto_restore', 13:48:18 INFO - 'tabpaint']}, 13:48:18 INFO - 'svgr': {'tests': ['tsvgx', 13:48:18 INFO - 'tsvgr_opacity', 13:48:18 INFO - 'tart', 13:48:18 INFO - 'tscrollx', 13:48:18 INFO - 'cart']}, 13:48:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:48:18 INFO - 'tests': ['tsvgx', 13:48:18 INFO - 'tsvgr_opacity', 13:48:18 INFO - 'tart', 13:48:18 INFO - 'tscrollx', 13:48:18 INFO - 'cart']}, 13:48:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:18 INFO - 'tests': ['tp5o']}, 13:48:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:18 INFO - 'talos_options': ['--e10s'], 13:48:18 INFO - 'tests': ['tp5o']}, 13:48:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:18 INFO - 'talos_options': ['--xperf_path', 13:48:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:18 INFO - 'tests': ['tp5n']}, 13:48:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:18 INFO - 'talos_options': ['--e10s', 13:48:18 INFO - '--xperf_path', 13:48:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:18 INFO - 'tests': ['tp5n']}}, 13:48:18 INFO - 'talos.zip': {'path': '', 13:48:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:48:18 INFO - Running post-action listener: _resource_record_post_action 13:48:18 INFO - ##### 13:48:18 INFO - ##### Running create-virtualenv step. 13:48:18 INFO - ##### 13:48:18 INFO - Running pre-action listener: _resource_record_pre_action 13:48:18 INFO - Running main action method: create_virtualenv 13:48:18 INFO - Creating virtualenv /builds/slave/test/build/venv 13:48:18 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 13:48:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:48:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:48:18 INFO - Using real prefix '/tools/python27' 13:48:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:48:19 INFO - Installing distribute.............................................................................................................................................................................................done. 13:48:22 INFO - Installing pip.................done. 13:48:22 INFO - Return code: 0 13:48:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feec859b2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f5d30>, '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 0x10c759db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ecb20>, '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.iXPRj9w0KK/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.aeTlQ028ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 13:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXPRj9w0KK/Render', 13:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:22 INFO - 'HOME': '/Users/cltbld', 13:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:22 INFO - 'LOGNAME': 'cltbld', 13:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:22 INFO - 'MOZ_NO_REMOTE': '1', 13:48:22 INFO - 'NO_EM_RESTART': '1', 13:48:22 INFO - 'PAGER': '/bin/cat', 13:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:22 INFO - 'PWD': '/builds/slave/test', 13:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:22 INFO - 'SHELL': '/bin/bash', 13:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aeTlQ028ss/Listeners', 13:48:22 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 13:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:22 INFO - 'USER': 'cltbld', 13:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:22 INFO - 'XPC_FLAGS': '0x0', 13:48:22 INFO - 'XPC_SERVICE_NAME': '0', 13:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:22 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 13:48:22 INFO - Cleaning up... 13:48:22 INFO - Return code: 0 13:48:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ca51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feec859b2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f5d30>, '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 0x10c759db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ecb20>, '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.iXPRj9w0KK/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.aeTlQ028ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 13:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXPRj9w0KK/Render', 13:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:22 INFO - 'HOME': '/Users/cltbld', 13:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:22 INFO - 'LOGNAME': 'cltbld', 13:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:22 INFO - 'MOZ_NO_REMOTE': '1', 13:48:22 INFO - 'NO_EM_RESTART': '1', 13:48:22 INFO - 'PAGER': '/bin/cat', 13:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:22 INFO - 'PWD': '/builds/slave/test', 13:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:22 INFO - 'SHELL': '/bin/bash', 13:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aeTlQ028ss/Listeners', 13:48:22 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 13:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:22 INFO - 'USER': 'cltbld', 13:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:22 INFO - 'XPC_FLAGS': '0x0', 13:48:22 INFO - 'XPC_SERVICE_NAME': '0', 13:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:23 INFO - Downloading/unpacking psutil>=0.7.1 13:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:48:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:26 INFO - Installing collected packages: psutil 13:48:26 INFO - Running setup.py install for psutil 13:48:26 INFO - building 'psutil._psutil_osx' extension 13:48:26 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 13:48:26 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 13:48:26 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 13:48:26 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 13:48:26 INFO - building 'psutil._psutil_posix' extension 13:48:27 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 13:48:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:48:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:48:27 INFO - ^ 13:48:27 INFO - 1 warning generated. 13:48:27 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 13:48:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:27 INFO - Successfully installed psutil 13:48:27 INFO - Cleaning up... 13:48:27 INFO - Return code: 0 13:48:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:48:27 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')]} 13:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:27 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')]} 13:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:27 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 0x10ca51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feec859b2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f5d30>, '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 0x10c759db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ecb20>, '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.iXPRj9w0KK/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.aeTlQ028ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 13:48:27 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 13:48:27 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 13:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXPRj9w0KK/Render', 13:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:27 INFO - 'HOME': '/Users/cltbld', 13:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:27 INFO - 'LOGNAME': 'cltbld', 13:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:27 INFO - 'MOZ_NO_REMOTE': '1', 13:48:27 INFO - 'NO_EM_RESTART': '1', 13:48:27 INFO - 'PAGER': '/bin/cat', 13:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:27 INFO - 'PWD': '/builds/slave/test', 13:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:27 INFO - 'SHELL': '/bin/bash', 13:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aeTlQ028ss/Listeners', 13:48:27 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 13:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:27 INFO - 'USER': 'cltbld', 13:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:27 INFO - 'XPC_FLAGS': '0x0', 13:48:27 INFO - 'XPC_SERVICE_NAME': '0', 13:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:48:30 INFO - Installing collected packages: mozsystemmonitor 13:48:30 INFO - Running setup.py install for mozsystemmonitor 13:48:30 INFO - Successfully installed mozsystemmonitor 13:48:30 INFO - Cleaning up... 13:48:30 INFO - Return code: 0 13:48:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:48: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')]} 13:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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', '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 0x10ca51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feec859b2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f5d30>, '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 0x10c759db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ecb20>, '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.iXPRj9w0KK/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.aeTlQ028ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 13:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:48: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 blobuploader==1.2.4 13:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXPRj9w0KK/Render', 13:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:30 INFO - 'HOME': '/Users/cltbld', 13:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:30 INFO - 'LOGNAME': 'cltbld', 13:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:30 INFO - 'MOZ_NO_REMOTE': '1', 13:48:30 INFO - 'NO_EM_RESTART': '1', 13:48:30 INFO - 'PAGER': '/bin/cat', 13:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:30 INFO - 'PWD': '/builds/slave/test', 13:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:30 INFO - 'SHELL': '/bin/bash', 13:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aeTlQ028ss/Listeners', 13:48:30 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 13:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:30 INFO - 'USER': 'cltbld', 13:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:30 INFO - 'XPC_FLAGS': '0x0', 13:48:30 INFO - 'XPC_SERVICE_NAME': '0', 13:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:32 INFO - Downloading blobuploader-1.2.4.tar.gz 13:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:48:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:48:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:34 INFO - Downloading docopt-0.6.1.tar.gz 13:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:48:34 INFO - Installing collected packages: blobuploader, requests, docopt 13:48:34 INFO - Running setup.py install for blobuploader 13:48:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:48:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:48:34 INFO - Running setup.py install for requests 13:48:34 INFO - Running setup.py install for docopt 13:48:34 INFO - Successfully installed blobuploader requests docopt 13:48:34 INFO - Cleaning up... 13:48:35 INFO - Return code: 0 13:48:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:35 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 0x10ca51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feec859b2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f5d30>, '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 0x10c759db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ecb20>, '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.iXPRj9w0KK/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.aeTlQ028ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 13:48:35 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 13:48:35 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 13:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXPRj9w0KK/Render', 13:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:35 INFO - 'HOME': '/Users/cltbld', 13:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:35 INFO - 'LOGNAME': 'cltbld', 13:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:35 INFO - 'MOZ_NO_REMOTE': '1', 13:48:35 INFO - 'NO_EM_RESTART': '1', 13:48:35 INFO - 'PAGER': '/bin/cat', 13:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:35 INFO - 'PWD': '/builds/slave/test', 13:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:35 INFO - 'SHELL': '/bin/bash', 13:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aeTlQ028ss/Listeners', 13:48:35 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 13:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:35 INFO - 'USER': 'cltbld', 13:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:35 INFO - 'XPC_FLAGS': '0x0', 13:48:35 INFO - 'XPC_SERVICE_NAME': '0', 13:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:48:35 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-bU0fNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:48:35 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-OxTRF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:48:35 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-MC7Vsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:48:35 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-NNTs5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:48:35 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-8pUbLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:48:35 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-467nTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:48:35 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-NG7OEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:48:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-qN2OS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:48:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-2KPKn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:48:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-OdhrWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:48:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-04l7Tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:48:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Vn0xdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:48:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-8VD327-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:48:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-0kfXN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:48:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-DsLBIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:48:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-MukqeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:48:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-tc4nV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:48:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:48:37 INFO - Running setup.py install for manifestparser 13:48:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:48:37 INFO - Running setup.py install for mozcrash 13:48:37 INFO - Running setup.py install for mozdebug 13:48:37 INFO - Running setup.py install for mozdevice 13:48:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:48:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:48:37 INFO - Running setup.py install for mozfile 13:48:37 INFO - Running setup.py install for mozhttpd 13:48:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:48:37 INFO - Running setup.py install for mozinfo 13:48:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:48:38 INFO - Running setup.py install for mozInstall 13:48:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:48:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:48:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:48:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:48:38 INFO - Running setup.py install for mozleak 13:48:38 INFO - Running setup.py install for mozlog 13:48:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:48:38 INFO - Running setup.py install for moznetwork 13:48:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:48:38 INFO - Running setup.py install for mozprocess 13:48:38 INFO - Running setup.py install for mozprofile 13:48:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:48:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:48:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:48:39 INFO - Running setup.py install for mozrunner 13:48:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:48:39 INFO - Running setup.py install for mozscreenshot 13:48:39 INFO - Running setup.py install for moztest 13:48:39 INFO - Running setup.py install for mozversion 13:48:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:48:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:48:39 INFO - Cleaning up... 13:48:39 INFO - Return code: 0 13:48:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:48:39 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')]} 13:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:39 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')]} 13:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:39 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 0x10ca51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feec859b2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f5d30>, '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 0x10c759db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ecb20>, '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.iXPRj9w0KK/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.aeTlQ028ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 13:48:39 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 13:48:39 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 13:48:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXPRj9w0KK/Render', 13:48:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:39 INFO - 'HOME': '/Users/cltbld', 13:48:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:39 INFO - 'LOGNAME': 'cltbld', 13:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:39 INFO - 'MOZ_NO_REMOTE': '1', 13:48:39 INFO - 'NO_EM_RESTART': '1', 13:48:39 INFO - 'PAGER': '/bin/cat', 13:48:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:39 INFO - 'PWD': '/builds/slave/test', 13:48:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:39 INFO - 'SHELL': '/bin/bash', 13:48:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aeTlQ028ss/Listeners', 13:48:39 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 13:48:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:39 INFO - 'USER': 'cltbld', 13:48:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:39 INFO - 'XPC_FLAGS': '0x0', 13:48:39 INFO - 'XPC_SERVICE_NAME': '0', 13:48:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:48:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-AferL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:48:40 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)) 13:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:48:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-6KqUJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:48:40 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)) 13:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:48:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-pC_3cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:48:40 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)) 13:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:48:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-5brQwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:48:40 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)) 13:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:48:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-pSx3Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:48:40 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)) 13:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:48:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-INUdHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:48:40 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)) 13:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:48:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Froz3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:48:40 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)) 13:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:48:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-tzGL_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:48:40 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)) 13:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:48:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-nl4X9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:48:40 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)) 13:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:48:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-2kLmWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:48:40 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)) 13:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:48:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Zsx_P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:48:41 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)) 13:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:48:41 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-03Cdox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:48:41 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)) 13:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:48:41 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-5ziSrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:48:41 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)) 13:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:48:41 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-bte7fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:48:41 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)) 13:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:48:41 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-ShV3b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:48:41 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)) 13:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:48:41 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-eqYA5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:48:41 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)) 13:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:48:41 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-3BXNVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:48:41 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)) 13:48:41 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)) 13:48:41 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)) 13:48:41 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)) 13:48:41 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)) 13:48:41 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)) 13:48:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:44 INFO - Downloading blessings-1.6.tar.gz 13:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:48:44 INFO - Installing collected packages: blessings 13:48:44 INFO - Running setup.py install for blessings 13:48:44 INFO - Successfully installed blessings 13:48:44 INFO - Cleaning up... 13:48:44 INFO - Return code: 0 13:48:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:48:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:48:44 INFO - Reading from file tmpfile_stdout 13:48:44 INFO - Current package versions: 13:48:44 INFO - blessings == 1.6 13:48:44 INFO - blobuploader == 1.2.4 13:48:44 INFO - docopt == 0.6.1 13:48:44 INFO - manifestparser == 1.1 13:48:44 INFO - mozInstall == 1.12 13:48:44 INFO - mozcrash == 0.17 13:48:44 INFO - mozdebug == 0.1 13:48:44 INFO - mozdevice == 0.48 13:48:44 INFO - mozfile == 1.2 13:48:44 INFO - mozhttpd == 0.7 13:48:44 INFO - mozinfo == 0.9 13:48:44 INFO - mozleak == 0.1 13:48:44 INFO - mozlog == 3.1 13:48:44 INFO - moznetwork == 0.27 13:48:44 INFO - mozprocess == 0.22 13:48:44 INFO - mozprofile == 0.28 13:48:44 INFO - mozrunner == 6.11 13:48:44 INFO - mozscreenshot == 0.1 13:48:44 INFO - mozsystemmonitor == 0.0 13:48:44 INFO - moztest == 0.7 13:48:44 INFO - mozversion == 1.4 13:48:44 INFO - psutil == 3.1.1 13:48:44 INFO - requests == 1.2.3 13:48:44 INFO - wsgiref == 0.1.2 13:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:44 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 0x10ca51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feec859b2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f5d30>, '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 0x10c759db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ecb20>, '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.iXPRj9w0KK/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.aeTlQ028ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 13:48:44 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 13:48:44 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 13:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXPRj9w0KK/Render', 13:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:44 INFO - 'HOME': '/Users/cltbld', 13:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:44 INFO - 'LOGNAME': 'cltbld', 13:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:44 INFO - 'MOZ_NO_REMOTE': '1', 13:48:44 INFO - 'NO_EM_RESTART': '1', 13:48:44 INFO - 'PAGER': '/bin/cat', 13:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:44 INFO - 'PWD': '/builds/slave/test', 13:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:44 INFO - 'SHELL': '/bin/bash', 13:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aeTlQ028ss/Listeners', 13:48:44 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 13:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:44 INFO - 'USER': 'cltbld', 13:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:44 INFO - 'XPC_FLAGS': '0x0', 13:48:44 INFO - 'XPC_SERVICE_NAME': '0', 13:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:45 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)) 13:48:45 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)) 13:48:45 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)) 13:48:45 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)) 13:48:45 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)) 13:48:45 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)) 13:48:45 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)) 13:48:45 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)) 13:48:45 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)) 13:48:45 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)) 13:48:45 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)) 13:48:45 INFO - Cleaning up... 13:48:45 INFO - Return code: 0 13:48:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:45 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 0x10ca51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feec859b2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f5d30>, '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 0x10c759db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ecb20>, '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.iXPRj9w0KK/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.aeTlQ028ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 13:48:45 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 13:48:45 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 13:48:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXPRj9w0KK/Render', 13:48:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:45 INFO - 'HOME': '/Users/cltbld', 13:48:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:45 INFO - 'LOGNAME': 'cltbld', 13:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:45 INFO - 'MOZ_NO_REMOTE': '1', 13:48:45 INFO - 'NO_EM_RESTART': '1', 13:48:45 INFO - 'PAGER': '/bin/cat', 13:48:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:45 INFO - 'PWD': '/builds/slave/test', 13:48:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:45 INFO - 'SHELL': '/bin/bash', 13:48:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aeTlQ028ss/Listeners', 13:48:45 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 13:48:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:45 INFO - 'USER': 'cltbld', 13:48:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:45 INFO - 'XPC_FLAGS': '0x0', 13:48:45 INFO - 'XPC_SERVICE_NAME': '0', 13:48:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:45 INFO - Downloading/unpacking jsonschema 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:48:47 INFO - Downloading/unpacking functools32 (from jsonschema) 13:48:47 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 13:48:47 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 13:48:47 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 13:48:47 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 13:48:47 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 13:48:47 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 13:48:48 INFO - Downloading functools32-3.2.3-2.tar.gz 13:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:48:48 INFO - warning: no files found matching '*.txt' 13:48:48 INFO - no previously-included directories found matching 'build' 13:48:48 INFO - no previously-included directories found matching 'dist' 13:48:48 INFO - no previously-included directories found matching '.git*' 13:48:48 INFO - Installing collected packages: jsonschema, functools32 13:48:48 INFO - Running setup.py install for functools32 13:48:48 INFO - warning: no files found matching '*.txt' 13:48:48 INFO - no previously-included directories found matching 'build' 13:48:48 INFO - no previously-included directories found matching 'dist' 13:48:48 INFO - no previously-included directories found matching '.git*' 13:48:48 INFO - Successfully installed jsonschema functools32 13:48:48 INFO - Cleaning up... 13:48:48 INFO - Return code: 0 13:48:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:48: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')]} 13:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feec859b2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f5d30>, '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 0x10c759db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ecb20>, '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.iXPRj9w0KK/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.aeTlQ028ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 13:48: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', 'flake8'] in /builds/slave/test/build 13:48: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 flake8 13:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXPRj9w0KK/Render', 13:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:48 INFO - 'HOME': '/Users/cltbld', 13:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:48 INFO - 'LOGNAME': 'cltbld', 13:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:48 INFO - 'MOZ_NO_REMOTE': '1', 13:48:48 INFO - 'NO_EM_RESTART': '1', 13:48:48 INFO - 'PAGER': '/bin/cat', 13:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:48 INFO - 'PWD': '/builds/slave/test', 13:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:48 INFO - 'SHELL': '/bin/bash', 13:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aeTlQ028ss/Listeners', 13:48:48 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 13:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:48 INFO - 'USER': 'cltbld', 13:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:48 INFO - 'XPC_FLAGS': '0x0', 13:48:48 INFO - 'XPC_SERVICE_NAME': '0', 13:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:48 INFO - Downloading/unpacking flake8 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:48:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:48:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:48:52 INFO - no previously-included directories found matching 'docs/_build' 13:48:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:48:52 INFO - Running setup.py install for pep8 13:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:48:52 INFO - no previously-included directories found matching 'docs/_build' 13:48:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:48:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:48:52 INFO - Cleaning up... 13:48:52 INFO - Return code: 0 13:48:52 INFO - Running post-action listener: _resource_record_post_action 13:48:52 INFO - Running post-action listener: _start_resource_monitoring 13:48:52 INFO - Starting resource monitoring. 13:48:52 INFO - ##### 13:48:52 INFO - ##### Running install step. 13:48:52 INFO - ##### 13:48:52 INFO - Running pre-action listener: _resource_record_pre_action 13:48:52 INFO - Running main action method: install 13:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:48:53 INFO - Reading from file tmpfile_stdout 13:48:53 INFO - Detecting whether we're running mozinstall >=1.0... 13:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:48:53 INFO - Reading from file tmpfile_stdout 13:48:53 INFO - Output received: 13:48:53 INFO - Usage: mozinstall [options] installer 13:48:53 INFO - Options: 13:48:53 INFO - -h, --help show this help message and exit 13:48:53 INFO - -d DEST, --destination=DEST 13:48:53 INFO - Directory to install application into. [default: 13:48:53 INFO - "/builds/slave/test"] 13:48:53 INFO - --app=APP Application being installed. [default: firefox] 13:48:53 INFO - mkdir: /builds/slave/test/build/application 13:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:49:25 INFO - Reading from file tmpfile_stdout 13:49:25 INFO - Output received: 13:49:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:49:25 INFO - Running post-action listener: _resource_record_post_action 13:49:25 INFO - ##### 13:49:25 INFO - ##### Running run-tests step. 13:49:25 INFO - ##### 13:49:25 INFO - Running pre-action listener: _resource_record_pre_action 13:49:25 INFO - Running main action method: run_tests 13:49:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:49:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:49:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:49:25 INFO - 2016-04-20 13:49:25.871 screenresolution[2206:63150] starting screenresolution argv=screenresolution get 13:49:25 INFO - 2016-04-20 13:49:25.874 screenresolution[2206:63150] Display 0: 1600x1200x32@60 13:49:25 INFO - 2016-04-20 13:49:25.880 screenresolution[2207:63152] starting screenresolution argv=screenresolution list 13:49:25 INFO - Available Modes on Display 0 13:49:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:49:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:49:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:49:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:49:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:49:26 INFO - Intel Iris: 13:49:26 INFO - Chipset Model: Intel Iris 13:49:26 INFO - Type: GPU 13:49:26 INFO - Bus: Built-In 13:49:26 INFO - VRAM (Dynamic, Max): 1536 MB 13:49:26 INFO - Vendor: Intel (0x8086) 13:49:26 INFO - Device ID: 0x0a2e 13:49:26 INFO - Revision ID: 0x0009 13:49:26 INFO - Displays: 13:49:26 INFO - Display: 13:49:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:49:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:49:26 INFO - Display Serial Number: 1600x1200 60 13:49:26 INFO - Main Display: Yes 13:49:26 INFO - Mirror: Off 13:49:26 INFO - Online: Yes 13:49:26 INFO - Rotation: Supported 13:49:26 INFO - Return code: 0 13:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:49:26 INFO - Python 2.7.3 13:49:26 INFO - Return code: 0 13:49:26 INFO - grabbing minidump binary from tooltool 13:49: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')]} 13:49:26 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 0x10c8f5d30>, '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 0x10c759db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8ecb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:49:26 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 13:49:26 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 13:49:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:49:26 INFO - Return code: 0 13:49:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:49:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:49:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:49:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:49:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:49:27 INFO - Return code: 0 13:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0193 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:49:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXPRj9w0KK/Render', 13:49:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:27 INFO - 'HOME': '/Users/cltbld', 13:49:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:27 INFO - 'LOGNAME': 'cltbld', 13:49:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:49:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:27 INFO - 'MOZ_NO_REMOTE': '1', 13:49:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:49:27 INFO - 'NO_EM_RESTART': '1', 13:49:27 INFO - 'PAGER': '/bin/cat', 13:49:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:27 INFO - 'PWD': '/builds/slave/test', 13:49:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:49:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:27 INFO - 'SHELL': '/bin/bash', 13:49:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aeTlQ028ss/Listeners', 13:49:27 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 13:49:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:27 INFO - 'USER': 'cltbld', 13:49:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:27 INFO - 'XPC_FLAGS': '0x0', 13:49:27 INFO - 'XPC_SERVICE_NAME': '0', 13:49:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:49:27 INFO - mozversion application_buildid: 20160420124052 13:49:27 INFO - mozversion application_changeset: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 13:49:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:49:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:49:27 INFO - mozversion application_name: Firefox 13:49:27 INFO - mozversion application_remotingname: firefox-dev 13:49:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:49:27 INFO - mozversion application_vendor: Mozilla 13:49:27 INFO - mozversion application_version: 47.0a2 13:49:27 INFO - mozversion platform_buildid: 20160420124052 13:49:27 INFO - mozversion platform_changeset: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 13:49:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:49:27 INFO - mozversion platform_version: 47.0a2 13:49:27 INFO - using testdate: 1461185367 13:49:27 INFO - actual date: 1461185367 13:49:27 INFO - starting webserver on 'localhost:51005' 13:49:27 INFO - SUITE-START | Running 2 tests 13:49:27 INFO - TEST-START | dromaeo_css 13:49:27 INFO - operating with platform_type : mac_ 13:49:27 INFO - Initialising browser for dromaeo_css test... 13:49:27 INFO - TEST-INFO | started process 2225 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpC27BrN/profile http://localhost:51005/getInfo.html) 13:49:30 INFO - PROCESS | 2225 | __metrics Screen width/height:1600/1200 13:49:30 INFO - PROCESS | 2225 | colorDepth:24 13:49:30 INFO - PROCESS | 2225 | Browser inner width/height: 1024/689 13:49:30 INFO - PROCESS | 2225 | __metrics 13:49:30 ERROR - PROCESS | 2225 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:49:30 INFO - TEST-INFO | 2225: exit 0 13:49:30 INFO - Browser initialized. 13:49:30 INFO - Running cycle 1/1 for dromaeo_css test... 13:49:30 INFO - TEST-INFO | started process 2228 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpC27BrN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:49:42 INFO - PROCESS | 2228 | RSS: Main: 217772032 13:49:42 INFO - PROCESS | 2228 | 13:50:32 INFO - PROCESS | 2228 | 1461185432502 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] 13:52:43 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:51005/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51005/tests/dromaeo/cssquery-ext.html) 13:52:44 INFO - PROCESS | 2228 | RSS: Main: 228724736 13:52:44 INFO - PROCESS | 2228 | 13:55:46 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:51005/tests/dromaeo/cssquery-ext.html (next: http://localhost:51005/tests/dromaeo/cssquery-jquery.html) 13:55:47 INFO - PROCESS | 2228 | RSS: Main: 240455680 13:55:47 INFO - PROCESS | 2228 | 13:58:48 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:51005/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51005/tests/dromaeo/cssquery-mootools.html) 13:58:49 INFO - PROCESS | 2228 | RSS: Main: 242655232 13:58:49 INFO - PROCESS | 2228 | 14:01:51 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:51005/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51005/tests/dromaeo/cssquery-prototype.html) 14:01:51 INFO - PROCESS | 2228 | RSS: Main: 243830784 14:01:51 INFO - PROCESS | 2228 | 14:04:54 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:51005/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51005/tests/dromaeo/cssquery-yui.html) 14:04:55 INFO - PROCESS | 2228 | RSS: Main: 247562240 14:04:55 INFO - PROCESS | 2228 | 14:07:57 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:51005/tests/dromaeo/cssquery-yui.html (next: http://localhost:51005/tests/dromaeo/cssquery-dojo.html) 14:07:57 INFO - PROCESS | 2228 | RSS: Main: 248401920 14:07:57 INFO - PROCESS | 2228 | 14:07:57 INFO - PROCESS | 2228 | __start_tp_report 14:07:57 INFO - PROCESS | 2228 | _x_x_mozilla_page_load 14:07:57 INFO - PROCESS | 2228 | _x_x_mozilla_page_load_details 14:07:57 INFO - PROCESS | 2228 | |i|pagename|runs| 14:07:57 INFO - PROCESS | 2228 | |0;dojo.html;3146.5909431773866;3491.2842867212225;3505.8948231553063;3516.1385460562165;3549.8935031949036;5734.627249228803;5744.770209191638;5763.740631671574;5782.132680097988;5831.446012628804;5774.307083150017;5785.27684039495;5804.245448091753;5816.738246778895;5826.650400975945;5143.485651434864;5150.587952963763;5228;5271.393789714193;5273.76268067936;5118.744062796864;5146.9485305146845;5263.131583288753;5266.447023062581;5282.550983166436;5232.241325007891;5265.131253343194;5271;5272.973635131819;5296.523312901838;5214.243934629495;5215.504527069922;5226.111561034633;5237.397699264595;5277.683338999634;5027;5067.239914012891;5079.593632509391;5147.510986456281;5168.379794424655;5523.751431185607;5524.033294173503;5552.444755524456;5565.972170139164;5582.330120385539;6159.938400615982;6212.720427580724;6230.844228894314;6232.750689972396;6240.126382306481;6124.228368151221;6166.383361663842;6173.382661733835;6216.533759968021;6265.59273647216;5874.530037596982;5897.32180799205;5902.734376953047;5903.793367232126;5914.349421563625;6292.087647291117;6292.433680968735;6301.117843501914;6303.212098487689;6307.653079080603;5989.341172471025;6093.086037094471;6123.4488895999575;6136.886723216021;6227.283862355887;6211.9068213976825;6232.875342493125;6235.220597425322;6254.718537665725;6262.530310226751;6182.258129024456;6210.347913469021;6227.034809604518;6242.875142497124;6245.875082498324;5745;5893.585539470582;6232.56372053961;6258.530610204253;6267.467265282411;4682.204025315705;4923.77842997066;4939.234418665041;4950.554450099508;4968.22992436173;4236.639885609758;4236.957630423718;4378.649708023414;4498.617617502484;4537.251353526697;4650.255959046604;5790.739416726257;5792.681402522818;5796.449337312949;5807.593468457252;6220.626762394271;6223.471004964538;6244.687765611701;6246.312905580383;6250.593711408744;5256.421793602701;5728.198052272685;5827.388124246893;5834.737436815353;5838.649681019152;5374.811881584125;5385.7576409061685;5407.053765591006;5420;5449.945500545023;6269.780557680459;6300.117983482316;6336.778212762531;6338.176037115146;6338.176037115238;6144.201253836973;6194.721237544231;6199.752009919553;6241.906371404341;6249.625022498664;6278.46633036197;6307.653079080511;6326.4622507087415;6337.90493142594;6340.175777149126;6192.876142477216;6238.438540531374;6242.157308763259;6244.313125556276;6249.78129264789;6152.723127459365;6154.723037463235;6202.689865506616;6241.438270555672;6269.247690277196;5455.863603409946;6138.877222455615;6165.815025549241;6167.198264225622;6174.66039367839;6156.907646385218;6169.784057557964;6179.907301390393;6182.783602573888;6188.164597779422;5866.325372582208;5868.061110222344;5885.264341957255;5976.8804623908145;6069.3020302665755;6132;6147.600405973598;6150.477209437248;6170.197874276495;6189.938100618936;6047.206453540449;6070.514358851369;6080.300765411857;6085.878282434415;6105 14:07:57 INFO - PROCESS | 2228 | |1;ext.html;535.4431391352994;607.1742430294798;616.8895987222998;666.5634009723631;673.7602810828076;39298.41052384216;40049.19901601974;40117.7994110029;40228.59771402281;40256.59743402569;41824;41964.74105776832;42162.36756448648;42319.36520952188;42466;9537.380070295443;9752.561134748954;9763.951180244088;9797.90202097977;9800.26498012652;9632.903670963271;9830.967748386423;9875.95062024689;9888.456134912612;9898.554565044591;9843.015698430172;9865.802683946316;9884.406935583853;9905;9917.752056198617;9803.2157427406;9886.901130988743;9900.55447504864;9904.059114384121;9906.752331191707;9671.70984870448;9760.926298107202;9807.509624518745;9819.214462842956;9825.312228144032;34626.82686586576;40746.79626601848;41065.1786964259;41102.38346424806;41215;3126.531020346966;3319.3527262183884;3381.120908563791;3543.769654972444;3702.4446333049987;27470.5879411809;27536.724632753616;27872.860635696896;28030.859845700845;28569;2563.3335332813417;2737.5893615957566;2800.7339302766204;2801.705820888818;2826.9293267668268;249627;287969;346373.9999999975;346432;348950.25524872466;39450;48573.757131214115;48968.75515622399;66980;68996;47843;47958;48175.5182448178;48203.5179648206;48260.75869620629;17093.572660683334;17133.485995420157;17223.22495487706;17369.65260694779;17448.91275543614;13499.595012149652;13598.252096134807;13623.931880340535;13662.590122296348;13668.863311366758;12525.498980040697;15325.31036103378;15730.606734831721;15777.211139442981;15890.284937177854;6597.340265973365;6729.461643068543;6761.29006454325;6762.763303284361;6767.511147547531;919.1819280840058;988.7478692933399;1039.8076355874186;1095.3592148593002;1139.3448766959032;30142.84928575343;30366;30726.924557640374;30777.0507651904;30926.964058524118;1128.4752590045505;1134.3987686526154;1139.2765593847967;1236.2829558855842;1274.566647339909;15288.770668439982;15719.292631831595;15869.365225391086;15913.124778137313;15990.200489975454;526076;527348;528760;532269.3386533043;533964;62898;63019.36980630227;63537;63774.68112659407;64036.67981660062;1270.2315099364937;1523.2840564934463;1548.3806477409125;1552.5420001099476;1568.4432026630382;29977.250568735955;30202.848985754932;30613.034037616093;30627.985668789275;30880.691193087783;53800.923981519365;54062.45937540574;54364;54777.99999999841;54870.451295486535;487132.69300959806;496510;497603;499738;501085;30714.84642576862;34603.13492162716;34832.30335393227;35416.29167416689;35738;44878;45222.77388613036;46777;47322.76338618285;48240.03519929652;32543;38697.61302387053;39257;39561.60438395579;40751.79624101861;37943.2411351777;38172.23655526818;38237;38967;39014.609853902235;38020.61979380171;38869.44522219079;38893.80553097217;39071.80464097661;39350;33129;34534.65465345415;34727.826360868035;34760.65239347574;34958.65041349656;24634.50730985406;25096;25735.871320643277;26077.348066298495;26361.340966475993 14:07:57 INFO - PROCESS | 2228 | |2;jquery.html;306.27107484187616;328.949012903;364.83035388544323;381.5497712699017;382.9674477669398;20481;21079.789202107993;21259.149634014622;21749.67375489365;21779.911004449794;20546.89726551369;21020.684689729627;21628.783712162913;21683.13267469299;22518.43703907403;5863.442972917566;6042.516598672096;6047.15339852421;6057.939420605803;6065;5007.9232964912535;5716.885207384541;5847.1521629363715;5906.350301466835;5969.671668058255;5390.6226564140525;5406.378266499363;5648.237487939116;5948.107783832416;6032.638041717511;5835.708214589275;5930.169776231331;6022.819315420545;6119.143319935212;6119.908201376983;4804.783784729696;5772.624779389326;5824.271966004249;5834.941650583482;5854.414558544111;21472.355829325144;25935.35161620956;26849.328766780793;27221.638918054017;27315;2392.5214957008666;2423.8182136339847;2531.607600821857;2678.3304173956512;2828.702986186462;10015.198784097327;10280;10438.425886576235;10476.109530689824;10801.081908037826;1793.6681713882974;1823.5896923192308;1841.6592930307936;1843.6404901044302;1912.550550620603;105807;108924.45537772261;110108.4494577522;111568;111898;10087.092161705481;11132.49903754333;11242.695247474248;11554.422278886022;11620.07039436843;14566.126032437876;14709.896757742998;14720.852791471949;14752.778708319383;14760.188189649672;7458.291462311072;9146.63413463454;9149.954250228839;9160.770980725401;9241.445513269226;7731.806704832312;8172.305354044854;9000.684976025808;9505.5722492488;9520.666776662783;4123.278426275389;4420.408652884958;4592.471865735416;4666.580007799314;4720.575148236607;1698.6178109925168;1920.8186965016414;1959.9706004409945;1997.5205950571758;2004.3285499357878;715.692252331492;982.2731178927543;1082.7780305037606;1093.639099097296;1102.9283096598695;20560.28039018627;20837.062332195088;20912.68630970537;21006.15975360999;21474.926253687252;905.7463910105181;1005.6228914157191;1025.6102680981328;1064.3986147826454;1081.221520505235;7702.576358300235;11675.649730507928;11722.531098756124;11746.353950532632;11770.646880593597;659055;659134;667925;677354;682423;103052;104424.47787761013;110471;117910;125953;1042.7132538551807;1046.278068133001;1052.9473526323652;1087.429099722652;1089.5641743302583;17999.1071871437;18573.34993275283;18819.435416937515;18877;18916;37408.438873417464;40663.78008659745;52006.95986080333;52734.472655272955;53150;72853;80363.39273214385;81345;84496;84935.575322123;8126.878096828434;8176.386770992318;8378.958105209678;8383.538905360263;8434.198751118634;9345.953270233606;10376.896231037896;12192.51229950792;12952.611421657366;13162.934185329395;10669.519871605951;10863.511141998471;10904.291221070605;11111.888881111085;11119.221654484109;10733.658292713411;10803.297785644223;11037.889621103686;11128.666140015812;11240.213185077293;6211.13044173807;9977;10306.505556694088;10391.792164156523;11260.211785174959;7050;8324.29243514284;8496.872546911678;8545.914540854512;8687.956560217412;8674.78313042179;11975.880241197476;11992.580259690869;12188.45151968146;12309.692257693629 14:07:57 INFO - PROCESS | 2228 | |3;mootools.html;1664.0681218517632;1691.983080169198;1898.2312163573758;1975.9901200493987;2048;8260.91739082609;8566.914330856705;9041.186293233608;9216.953915230422;9252.398594091379;8850;8852.867206991885;8884.333674974387;8957.283417326615;8976.192142707156;2551.8341307815026;2570.0876188952934;2573.1122762646855;2579.5614745493217;2595.2473782603115;2359.0210062823908;2442.3894026493376;2530.772230499255;2579.8710064496795;2586.715461299265;2530.8228424010326;2570.4602033572974;2576.780973617245;2585.663863697717;2591.080166540879;2570.3060173753074;2586.043164029312;2593.610958356243;2595.5717306644383;2603.06289735695;2548.643189953408;2560.6031065184925;2572.884220210095;2582.806289528293;2589.7928165746694;7623.275788800055;9027.368084234105;9031.683891063847;9046.411983221135;9062.954685226598;4632.2356811126465;5623.325200975909;5664.603477756517;5689.118186681071;5755.740991655343;3007.45865744166;3709.3694072007825;3730.08612889841;3760.7179461540222;3790.033541446941;934.3366209990915;1063.595833583241;1086.6902932664152;1092.5520536579963;1100.8678958524947;12362;12523.311217883012;12541.874581254162;12578.371081445983;12579.308138052404;4200.4539409876525;4364.476262848479;4783.832565860178;4989.326440930428;5030.572401345853;8588.527630980356;10521.52653130611;10582.994615511514;10602.363858168535;10627.628033018807;5624.606277560531;5688.345840228427;5694.08894576874;5736.397678243808;5760.913586296209;4621.214393553104;4985.227289770091;5124.128898087334;5125.589952803767;5139.074966506065;4078.7384274286433;4108.548059713429;4122.732022418533;4130.194612050681;4146.626803587692;1371.71879764648;1377.7726675098697;1391.6033930330009;1395.1838174667932;1402.2848347342929;1314.4413624209865;1427.750143724844;1456.1408768826443;1457.2640816387657;1478.7929689843431;8441.240288374076;8460.196281353261;8511.233988941025;8514.403991720521;8578.356623253281;526.4883326075335;529.2669652531272;530.6709839899287;539.8326518779191;541.8891272890559;6290.779822706275;6328.873422531524;6354.872902541923;6396.9360306397275;6402.903956440658;10878.728031799268;11242.156838237;11293.830592541119;11330.830037549444;11386.544538218379;10714.624988125533;10975.780484390427;11007.61473348429;11141.944290278496;11208.439578021067;7226.602536860523;8658.264047555902;8661.220490155916;8686.218240358272;8748.47509149453;7974.681012759424;8065;8127.512349259064;8187.79530511742;8202.302804261704;9631.181349585084;9757.316987810786;9804.65683701067;9914.20686345105;10007.799844002933;10027.448490333101;10380.221483388927;10461.843072353768;10510.894891051297;10526.157907367238;7284.417246620364;7605.88591171144;7681.539107653559;7747.845043098993;7811.765647030598;8475.279601233964;8483.74548763538;8544.700935467228;8554.828903421772;8558.614862331335;7459.36595389398;7717.884231736641;7731.536107833548;7749.263819937097;7790.220977902164;6897.517173797786;7447.515911465955;7542.660580273791;7550.5469671819865;7678.155402905788;8050.5572193529915;8126.796830079295;8138.3082437993435;8168.469049511763;8176.632051557814;7189.604571748604;7250.709971601077;7274.199838017708;7323.523970941872;7324.9633751833035;7392.741254056083;7440.107187137578;7446.478746487911;7458.067741532309;7477.065366829146 14:07:57 INFO - PROCESS | 2228 | |4;prototype.html;319.94720871056273;341.5048180138799;343.09936416905623;347.5065407121887;350.47778809573725;5651.9152212716845;6684.699188536515;6804.931950680491;6814.931850681492;6820.965895170523;6767.9019503953805;6777.796666100013;6777.966110169455;6797.456203503721;6812.761553345622;4727.929081063787;4812.25410061441;4920.188168952119;5011.974940125294;5016.172331565287;4955.231939049453;4967.776450059738;4974.079795237874;5010.223415370605;5081.314022606956;3710.5732840723394;4280.700350975433;4316.179925814101;4477.820887164526;4972.254161875711;4891.559759621633;4993.500649935014;4993.525615066581;4995.975020124876;4998.675086119427;4289.4852617685765;4298.634616057639;4302.634276086536;4308.870733877989;4309.5690430956965;5470.835874923759;6325.430711236011;6373.490120790326;6574.441172500296;6590.110335104748;5924.377940316291;5928.555358348141;5951.345352011275;5974.4921681657115;5987.251593550806;5789.594728369016;5818.7672493100645;7217.427373450176;7231.855362892766;7238.819029524251;4806.951930480685;4849.878753031167;4853.805847766121;4856.125897338477;4863.27050942358;6131;7666.9616651916385;7676.577788221645;7678.385729141655;7692.499987500794;3880.611938806097;4756.381670382828;4784.904301913943;4838.862867226199;4922.1140194765285;4880.121578115903;4891.951080489221;4915.115279249698;4922.655414121049;4927.103065319806;5878.617889837147;5881.735321910524;5888.587798854125;5892.9116063258225;5913.05391137416;7356.411487081021;7361.595112268877;7384.932218978694;7385.519941203805;7401.629918504161;1680;1703.5144983679593;1707.0184643829848;1707.9829201708073;1709.572606848288;1048.6434612231878;1084.4957094950885;1085.316250762015;1089.455272363818;1110.3337997201616;6753.831154221086;6825.522213445011;6842.692078856463;6860.108185935796;6873.553219040747;7634.541927484258;7634.770956871303;7638.541687498768;7647.541147531166;7653.5407875526535;6630.237522684856;6767.1202743644;6918.308169183041;6918.619475928872;6932.584044957319;4028.1540876415693;4055;4058.776767277769;4072.6131017553284;4074.490688663917;7953.488837120928;7957.880631790527;7974.481658692166;7979.1699984008;8005.039395272604;7612.467127301035;7929.722459713882;7934.246246606564;7937.404694647925;7966.442349035628;7838.098618658813;7863.52818830872;7874.133845277015;7911.881321780178;7936.642851071716;5754.935336962675;7284.3808276294985;7643.617819108911;7697.769066928001;7709.4603377763015;7509.399248060033;7509.88735168962;7514.774556763306;7518.624068796647;7531.058617672791;6543.574667646588;7119.6084215368655;7912.36701063925;7915.604219789103;7942.682292708227;4257.4252475915355;4807.975960120177;4808.447028591757;4860.92708609364;4874.8050077997905;7640.3505702015955;7646.082470103624;7663.501872378278;7669.079710434784;7726.227377262228;5967.492763115184;7349.412047036331;7367.594782286811;7377.668004939684;7382.778516644509;6385.97824348102;7002.719891204499;7079.256678048937;7347.19180890091;7386.519876208029;7137.892931605927;7149.034880291094;7165.749198778226;7176.605286709281;7197.892031619425;7313.744018959311;7330.230325815713;7330.96334518324;7338.486305958531;7342.3758980487255;5855.385184555731;6130.896438640909;6866.965665171842;7158.105236845395;7174.282571742784 14:07:57 INFO - PROCESS | 2228 | |5;yui.html;652.2271108736146;712.5617745086773;716.3481232078813;733.4205977277951;799.3684988858798;15218.23908804561;15404.691906161897;15483.767743483857;15512.84487155128;15523.611909702264;11820.231684940494;14420.855791442082;14447.422103115889;14530.636734081627;14558.272086395664;782.6986610155075;962.3648392061241;970.912617864392;988.1650005745134;989.9703008909744;964.5418426247546;970.7136394763527;976.6825781620967;979.56409397818;985.1527686189871;787.252110495032;999.8250306196422;1015.791762688647;1019.1541020952628;1026.9127124194415;973.9610415583368;975.4098770244042;995.4027583449908;996.3324572536418;1007.8034783217275;739.6264886232472;761.7448154868126;762.7406681728239;771.7067514344569;775.5734346109617;15386.15376154311;15519.146446945413;15584.688306233926;15689.686206275925;15729.764053539206;13365.331733413388;13392.933035334858;13451.66370840727;13549;13620.318984050857;10241.539130739135;10385.948070259676;10415.427151506665;10458.52936617854;10530.42082685452;3580.4092324766384;3586.2648157127987;3588.1926566522584;3595.3708101082207;3618.855245790165;88922.66616000765;89446;90794;90888.63667045;90959.54520227422;9748.415095094175;9898.505074746234;9908.504574771232;9983.051610097029;10003.849942250872;23684;23736.287911362688;23744.64383034256;23766.405839853796;23830.88084559566;6894.207166175854;7024.438044956391;7655;7683.884741728879;7724.420668449889;4179.665626749853;4204.642605378577;4234.745915245096;4285.735678025717;4315.654747620183;3738.2897249522503;3768.736188466781;3774.1319496515957;3803.23935212953;3815.542134943769;680.550836447942;690.433844247722;699.4264702943537;700.579652208681;732.9413646908234;524.9265102885599;530.8036026670156;596.4959609130278;622.757124721359;624.2134910013416;5753.294964745729;6044.667543285073;6957.1651401832105;8377.49735015901;8384.664613415394;527.9472052794766;615.9784407545715;618.8236352639476;634.7207228819304;660.6531570925303;3862.2661694278;3907.1013666856784;3908.3160446922243;3920.7059470539252;4064.7357921734992;89533.10466895248;95856;100540;102163.48918255362;102383;86614;86631;87386.56306718425;87885;88404.6739298911;66807.66596166987;76843.23156768472;76896.23103769003;77517;77858.61070694723;7527.059117610299;7585.975893254561;7782.338501227459;7963.601819909098;8173.5504547250475;38372.424413633256;39197.21605567815;48747.5125248743;49101.263481048525;55813.72093139508;62346.688266558376;72120;73522;75580;75766.24233757812;11488.770224595293;11556.884431155917;11560.884391155982;11647.184697071123;11831.935125838716;11895.76208475843;11934.104942129548;12028.27830330183;12377.876221237673;12421.19262247951;11302.83045754298;11311.981921626764;11757.294562326288;11780.469878855301;11963.581274655346;8897.688580899638;11050.06074483678;11286.266392684449;11291.943540282246;11774.882251177378;10900.127989760642;11167.664970050586;11197.72005699864;11476.483558239732;11655.067594592243;9338.95330523343;9382.202512786216;9498.715038548855;9568.378055426376;9668.75828104303;7677.30904218623;9406.200472959876;9696.272114783284;9751.75620609462;9762 14:07:57 INFO - PROCESS | 2228 | __end_tp_report 14:07:57 INFO - PROCESS | 2228 | __start_cc_report 14:07:57 INFO - PROCESS | 2228 | _x_x_mozilla_cycle_collect,365 14:07:57 INFO - PROCESS | 2228 | __end_cc_report 14:07:57 INFO - PROCESS | 2228 | __startTimestamp1461186477505__endTimestamp 14:07:57 INFO - PROCESS | 2228 | 14:07:57 INFO - PROCESS | 2228 | ------- Summary: start ------- 14:07:57 INFO - PROCESS | 2228 | Number of tests: 6 14:07:57 INFO - PROCESS | 2228 | 14:07:57 INFO - PROCESS | 2228 | [#0] dojo.html Cycles:165 Average:5747.67 Median:5989.34 stddev:644.89 (10.8%) stddev-sans-first:613.73 14:07:57 INFO - PROCESS | 2228 | Values: 3146.6 3491.3 3505.9 3516.1 3549.9 5734.6 5744.8 5763.7 5782.1 5831.4 5774.3 5785.3 5804.2 5816.7 5826.7 5143.5 5150.6 5228.0 5271.4 5273.8 5118.7 5146.9 5263.1 5266.4 5282.6 5232.2 5265.1 5271.0 5273.0 5296.5 5214.2 5215.5 5226.1 5237.4 5277.7 5027.0 5067.2 5079.6 5147.5 5168.4 5523.8 5524.0 5552.4 5566.0 5582.3 6159.9 6212.7 6230.8 6232.8 6240.1 6124.2 6166.4 6173.4 6216.5 6265.6 5874.5 5897.3 5902.7 5903.8 5914.3 6292.1 6292.4 6301.1 6303.2 6307.7 5989.3 6093.1 6123.4 6136.9 6227.3 6211.9 6232.9 6235.2 6254.7 6262.5 6182.3 6210.3 6227.0 6242.9 6245.9 5745.0 5893.6 6232.6 6258.5 6267.5 4682.2 4923.8 4939.2 4950.6 4968.2 4236.6 4237.0 4378.6 4498.6 4537.3 4650.3 5790.7 5792.7 5796.4 5807.6 6220.6 6223.5 6244.7 6246.3 6250.6 5256.4 5728.2 5827.4 5834.7 5838.6 5374.8 5385.8 5407.1 5420.0 5449.9 6269.8 6300.1 6336.8 6338.2 6338.2 6144.2 6194.7 6199.8 6241.9 6249.6 6278.5 6307.7 6326.5 6337.9 6340.2 6192.9 6238.4 6242.2 6244.3 6249.8 6152.7 6154.7 6202.7 6241.4 6269.2 5455.9 6138.9 6165.8 6167.2 6174.7 6156.9 6169.8 6179.9 6182.8 6188.2 5866.3 5868.1 5885.3 5976.9 6069.3 6132.0 6147.6 6150.5 6170.2 6189.9 6047.2 6070.5 6080.3 6085.9 6105.0 14:07:57 INFO - PROCESS | 2228 | 14:07:57 INFO - PROCESS | 2228 | [#1] ext.html Cycles:180 Average:59930.99 Median:39277.71 stddev:121705.55 (309.9%) stddev-sans-first:121965.26 14:07:57 INFO - PROCESS | 2228 | Values: 535.4 607.2 616.9 666.6 673.8 39298.4 40049.2 40117.8 40228.6 40256.6 41824.0 41964.7 42162.4 42319.4 42466.0 9537.4 9752.6 9764.0 9797.9 9800.3 9632.9 9831.0 9876.0 9888.5 9898.6 9843.0 9865.8 9884.4 9905.0 9917.8 9803.2 9886.9 9900.6 9904.1 9906.8 9671.7 9760.9 9807.5 9819.2 9825.3 34626.8 40746.8 41065.2 41102.4 41215.0 3126.5 3319.4 3381.1 3543.8 3702.4 27470.6 27536.7 27872.9 28030.9 28569.0 2563.3 2737.6 2800.7 2801.7 2826.9 249627.0 287969.0 346374.0 346432.0 348950.3 39450.0 48573.8 48968.8 66980.0 68996.0 47843.0 47958.0 48175.5 48203.5 48260.8 17093.6 17133.5 17223.2 17369.7 17448.9 13499.6 13598.3 13623.9 13662.6 13668.9 12525.5 15325.3 15730.6 15777.2 15890.3 6597.3 6729.5 6761.3 6762.8 6767.5 919.2 988.7 1039.8 1095.4 1139.3 30142.8 30366.0 30726.9 30777.1 30927.0 1128.5 1134.4 1139.3 1236.3 1274.6 15288.8 15719.3 15869.4 15913.1 15990.2 526076.0 527348.0 528760.0 532269.3 533964.0 62898.0 63019.4 63537.0 63774.7 64036.7 1270.2 1523.3 1548.4 1552.5 1568.4 29977.3 30202.8 30613.0 30628.0 30880.7 53800.9 54062.5 54364.0 54778.0 54870.5 487132.7 496510.0 497603.0 499738.0 501085.0 30714.8 34603.1 34832.3 35416.3 35738.0 44878.0 45222.8 46777.0 47322.8 48240.0 32543.0 38697.6 39257.0 39561.6 40751.8 37943.2 38172.2 38237.0 38967.0 39014.6 38020.6 38869.4 38893.8 39071.8 39350.0 33129.0 34534.7 34727.8 34760.7 34958.7 24634.5 25096.0 25735.9 26077.3 26361.3 14:07:57 INFO - PROCESS | 2228 | 14:07:57 INFO - PROCESS | 2228 | [#2] jquery.html Cycles:180 Average:36290.37 Median:21764.79 stddev:110619.33 (508.2%) stddev-sans-first:110896.65 14:07:57 INFO - PROCESS | 2228 | Values: 306.3 328.9 364.8 381.5 383.0 20481.0 21079.8 21259.1 21749.7 21779.9 20546.9 21020.7 21628.8 21683.1 22518.4 5863.4 6042.5 6047.2 6057.9 6065.0 5007.9 5716.9 5847.2 5906.4 5969.7 5390.6 5406.4 5648.2 5948.1 6032.6 5835.7 5930.2 6022.8 6119.1 6119.9 4804.8 5772.6 5824.3 5834.9 5854.4 21472.4 25935.4 26849.3 27221.6 27315.0 2392.5 2423.8 2531.6 2678.3 2828.7 10015.2 10280.0 10438.4 10476.1 10801.1 1793.7 1823.6 1841.7 1843.6 1912.6 105807.0 108924.5 110108.4 111568.0 111898.0 10087.1 11132.5 11242.7 11554.4 11620.1 14566.1 14709.9 14720.9 14752.8 14760.2 7458.3 9146.6 9150.0 9160.8 9241.4 7731.8 8172.3 9000.7 9505.6 9520.7 4123.3 4420.4 4592.5 4666.6 4720.6 1698.6 1920.8 1960.0 1997.5 2004.3 715.7 982.3 1082.8 1093.6 1102.9 20560.3 20837.1 20912.7 21006.2 21474.9 905.7 1005.6 1025.6 1064.4 1081.2 7702.6 11675.6 11722.5 11746.4 11770.6 659055.0 659134.0 667925.0 677354.0 682423.0 103052.0 104424.5 110471.0 117910.0 125953.0 1042.7 1046.3 1052.9 1087.4 1089.6 17999.1 18573.3 18819.4 18877.0 18916.0 37408.4 40663.8 52007.0 52734.5 53150.0 72853.0 80363.4 81345.0 84496.0 84935.6 8126.9 8176.4 8379.0 8383.5 8434.2 9346.0 10376.9 12192.5 12952.6 13162.9 10669.5 10863.5 10904.3 11111.9 11119.2 10733.7 10803.3 11037.9 11128.7 11240.2 6211.1 9977.0 10306.5 10391.8 11260.2 7050.0 8324.3 8496.9 8545.9 8688.0 8674.8 11975.9 11992.6 12188.5 12309.7 14:07:57 INFO - PROCESS | 2228 | 14:07:57 INFO - PROCESS | 2228 | [#3] mootools.html Cycles:180 Average:6243.73 Median:527.88 stddev:3319.54 (628.8%) stddev-sans-first:3311.01 14:07:57 INFO - PROCESS | 2228 | Values: 1664.1 1692.0 1898.2 1976.0 2048.0 8260.9 8566.9 9041.2 9217.0 9252.4 8850.0 8852.9 8884.3 8957.3 8976.2 2551.8 2570.1 2573.1 2579.6 2595.2 2359.0 2442.4 2530.8 2579.9 2586.7 2530.8 2570.5 2576.8 2585.7 2591.1 2570.3 2586.0 2593.6 2595.6 2603.1 2548.6 2560.6 2572.9 2582.8 2589.8 7623.3 9027.4 9031.7 9046.4 9063.0 4632.2 5623.3 5664.6 5689.1 5755.7 3007.5 3709.4 3730.1 3760.7 3790.0 934.3 1063.6 1086.7 1092.6 1100.9 12362.0 12523.3 12541.9 12578.4 12579.3 4200.5 4364.5 4783.8 4989.3 5030.6 8588.5 10521.5 10583.0 10602.4 10627.6 5624.6 5688.3 5694.1 5736.4 5760.9 4621.2 4985.2 5124.1 5125.6 5139.1 4078.7 4108.5 4122.7 4130.2 4146.6 1371.7 1377.8 1391.6 1395.2 1402.3 1314.4 1427.8 1456.1 1457.3 1478.8 8441.2 8460.2 8511.2 8514.4 8578.4 526.5 529.3 530.7 539.8 541.9 6290.8 6328.9 6354.9 6396.9 6402.9 10878.7 11242.2 11293.8 11330.8 11386.5 10714.6 10975.8 11007.6 11141.9 11208.4 7226.6 8658.3 8661.2 8686.2 8748.5 7974.7 8065.0 8127.5 8187.8 8202.3 9631.2 9757.3 9804.7 9914.2 10007.8 10027.4 10380.2 10461.8 10510.9 10526.2 7284.4 7605.9 7681.5 7747.8 7811.8 8475.3 8483.7 8544.7 8554.8 8558.6 7459.4 7717.9 7731.5 7749.3 7790.2 6897.5 7447.5 7542.7 7550.5 7678.2 8050.6 8126.8 8138.3 8168.5 8176.6 7189.6 7250.7 7274.2 7323.5 7325.0 7392.7 7440.1 7446.5 7458.1 7477.1 14:07:57 INFO - PROCESS | 2228 | 14:07:57 INFO - PROCESS | 2228 | [#4] prototype.html Cycles:180 Average:5913.15 Median:6657.47 stddev:1914.43 (28.8%) stddev-sans-first:1873.21 14:07:57 INFO - PROCESS | 2228 | Values: 319.9 341.5 343.1 347.5 350.5 5651.9 6684.7 6804.9 6814.9 6821.0 6767.9 6777.8 6778.0 6797.5 6812.8 4727.9 4812.3 4920.2 5012.0 5016.2 4955.2 4967.8 4974.1 5010.2 5081.3 3710.6 4280.7 4316.2 4477.8 4972.3 4891.6 4993.5 4993.5 4996.0 4998.7 4289.5 4298.6 4302.6 4308.9 4309.6 5470.8 6325.4 6373.5 6574.4 6590.1 5924.4 5928.6 5951.3 5974.5 5987.3 5789.6 5818.8 7217.4 7231.9 7238.8 4807.0 4849.9 4853.8 4856.1 4863.3 6131.0 7667.0 7676.6 7678.4 7692.5 3880.6 4756.4 4784.9 4838.9 4922.1 4880.1 4892.0 4915.1 4922.7 4927.1 5878.6 5881.7 5888.6 5892.9 5913.1 7356.4 7361.6 7384.9 7385.5 7401.6 1680.0 1703.5 1707.0 1708.0 1709.6 1048.6 1084.5 1085.3 1089.5 1110.3 6753.8 6825.5 6842.7 6860.1 6873.6 7634.5 7634.8 7638.5 7647.5 7653.5 6630.2 6767.1 6918.3 6918.6 6932.6 4028.2 4055.0 4058.8 4072.6 4074.5 7953.5 7957.9 7974.5 7979.2 8005.0 7612.5 7929.7 7934.2 7937.4 7966.4 7838.1 7863.5 7874.1 7911.9 7936.6 5754.9 7284.4 7643.6 7697.8 7709.5 7509.4 7509.9 7514.8 7518.6 7531.1 6543.6 7119.6 7912.4 7915.6 7942.7 4257.4 4808.0 4808.4 4860.9 4874.8 7640.4 7646.1 7663.5 7669.1 7726.2 5967.5 7349.4 7367.6 7377.7 7382.8 6386.0 7002.7 7079.3 7347.2 7386.5 7137.9 7149.0 7165.7 7176.6 7197.9 7313.7 7330.2 7331.0 7338.5 7342.4 5855.4 6130.9 6867.0 7158.1 7174.3 14:07:57 INFO - PROCESS | 2228 | 14:07:57 INFO - PROCESS | 2228 | [#5] yui.html Cycles:180 Average:19246.06 Median:3174.90 stddev:27881.84 (878.2%) stddev-sans-first:27925.10 14:07:57 INFO - PROCESS | 2228 | Values: 652.2 712.6 716.3 733.4 799.4 15218.2 15404.7 15483.8 15512.8 15523.6 11820.2 14420.9 14447.4 14530.6 14558.3 782.7 962.4 970.9 988.2 990.0 964.5 970.7 976.7 979.6 985.2 787.3 999.8 1015.8 1019.2 1026.9 974.0 975.4 995.4 996.3 1007.8 739.6 761.7 762.7 771.7 775.6 15386.2 15519.1 15584.7 15689.7 15729.8 13365.3 13392.9 13451.7 13549.0 13620.3 10241.5 10385.9 10415.4 10458.5 10530.4 3580.4 3586.3 3588.2 3595.4 3618.9 88922.7 89446.0 90794.0 90888.6 90959.5 9748.4 9898.5 9908.5 9983.1 10003.8 23684.0 23736.3 23744.6 23766.4 23830.9 6894.2 7024.4 7655.0 7683.9 7724.4 4179.7 4204.6 4234.7 4285.7 4315.7 3738.3 3768.7 3774.1 3803.2 3815.5 680.6 690.4 699.4 700.6 732.9 524.9 530.8 596.5 622.8 624.2 5753.3 6044.7 6957.2 8377.5 8384.7 527.9 616.0 618.8 634.7 660.7 3862.3 3907.1 3908.3 3920.7 4064.7 89533.1 95856.0 100540.0 102163.5 102383.0 86614.0 86631.0 87386.6 87885.0 88404.7 66807.7 76843.2 76896.2 77517.0 77858.6 7527.1 7586.0 7782.3 7963.6 8173.6 38372.4 39197.2 48747.5 49101.3 55813.7 62346.7 72120.0 73522.0 75580.0 75766.2 11488.8 11556.9 11560.9 11647.2 11831.9 11895.8 11934.1 12028.3 12377.9 12421.2 11302.8 11312.0 11757.3 11780.5 11963.6 8897.7 11050.1 11286.3 11291.9 11774.9 10900.1 11167.7 11197.7 11476.5 11655.1 9339.0 9382.2 9498.7 9568.4 9668.8 7677.3 9406.2 9696.3 9751.8 9762.0 14:07:57 INFO - PROCESS | 2228 | -------- Summary: end -------- 14:07:57 INFO - PROCESS | 2228 | 14:07:58 INFO - TEST-INFO | 2228: exit 0 14:07:58 INFO - TEST-OK | dromaeo_css | took 1110417ms 14:07:58 INFO - TEST-START | kraken 14:07:58 INFO - operating with platform_type : mac_ 14:07:58 INFO - Initialising browser for kraken test... 14:07:58 INFO - TEST-INFO | started process 2232 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpvLVte4/profile http://localhost:51005/getInfo.html) 14:08:00 INFO - PROCESS | 2232 | __metrics Screen width/height:1600/1200 14:08:00 INFO - PROCESS | 2232 | colorDepth:24 14:08:00 INFO - PROCESS | 2232 | Browser inner width/height: 1024/689 14:08:00 INFO - PROCESS | 2232 | __metrics 14:08:00 ERROR - PROCESS | 2232 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:08:01 INFO - TEST-INFO | 2232: exit 0 14:08:01 INFO - Browser initialized. 14:08:01 INFO - Running cycle 1/1 for kraken test... 14:08:01 INFO - TEST-INFO | started process 2235 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpvLVte4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:13 INFO - PROCESS | 2235 | RSS: Main: 217915392 14:08:13 INFO - PROCESS | 2235 | 14:08:16 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51005/tests/kraken/driver.html?testName=audio-beat-detection) 14:08:16 INFO - PROCESS | 2235 | RSS: Main: 229851136 14:08:16 INFO - PROCESS | 2235 | 14:08:19 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51005/tests/kraken/driver.html?testName=audio-dft) 14:08:20 INFO - PROCESS | 2235 | RSS: Main: 238989312 14:08:20 INFO - PROCESS | 2235 | 14:08:23 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51005/tests/kraken/driver.html?testName=audio-fft) 14:08:24 INFO - PROCESS | 2235 | RSS: Main: 243359744 14:08:24 INFO - PROCESS | 2235 | 14:08:26 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51005/tests/kraken/driver.html?testName=audio-oscillator) 14:08:26 INFO - PROCESS | 2235 | RSS: Main: 243699712 14:08:26 INFO - PROCESS | 2235 | 14:08:28 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51005/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:08:29 INFO - PROCESS | 2235 | RSS: Main: 244129792 14:08:29 INFO - PROCESS | 2235 | 14:08:32 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51005/tests/kraken/driver.html?testName=imaging-darkroom) 14:08:33 INFO - PROCESS | 2235 | RSS: Main: 244076544 14:08:33 INFO - PROCESS | 2235 | 14:08:35 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51005/tests/kraken/driver.html?testName=imaging-desaturate) 14:08:36 INFO - PROCESS | 2235 | RSS: Main: 244097024 14:08:36 INFO - PROCESS | 2235 | 14:08:39 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51005/tests/kraken/driver.html?testName=json-parse-financial) 14:08:40 INFO - PROCESS | 2235 | RSS: Main: 245018624 14:08:40 INFO - PROCESS | 2235 | 14:08:41 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51005/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:08:42 INFO - PROCESS | 2235 | RSS: Main: 244482048 14:08:42 INFO - PROCESS | 2235 | 14:08:44 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51005/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:08:44 INFO - PROCESS | 2235 | RSS: Main: 244318208 14:08:44 INFO - PROCESS | 2235 | 14:08:46 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51005/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:08:47 INFO - PROCESS | 2235 | RSS: Main: 245170176 14:08:47 INFO - PROCESS | 2235 | 14:08:49 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:08:50 INFO - PROCESS | 2235 | RSS: Main: 245321728 14:08:50 INFO - PROCESS | 2235 | 14:08:52 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:08:53 INFO - PROCESS | 2235 | RSS: Main: 244838400 14:08:53 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:51005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51005/tests/kraken/driver.html?testName=ai-astar) 14:08:55 INFO - PROCESS | 2235 | RSS: Main: 246775808 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | __start_tp_report 14:08:55 INFO - PROCESS | 2235 | _x_x_mozilla_page_load 14:08:55 INFO - PROCESS | 2235 | _x_x_mozilla_page_load_details 14:08:55 INFO - PROCESS | 2235 | |i|pagename|runs| 14:08:55 INFO - PROCESS | 2235 | |0;ai-astar;115;108;114;141;169;169;113;116;113;113 14:08:55 INFO - PROCESS | 2235 | |1;audio-beat-detection;155;142;192;182;120;143;123;183;183;150 14:08:55 INFO - PROCESS | 2235 | |2;audio-dft;199;194;165;242;274;259;196;202;198;197 14:08:55 INFO - PROCESS | 2235 | |3;audio-fft;61;64;77;114;63;79;82;85;159;47 14:08:55 INFO - PROCESS | 2235 | |4;audio-oscillator;85;85;124;81;77;79;115;78;79;119 14:08:55 INFO - PROCESS | 2235 | |5;imaging-gaussian-blur;91;100;135;88;112;84;136;131;92;90 14:08:55 INFO - PROCESS | 2235 | |6;imaging-darkroom;96;96;96;96;96;95;96;100;90;131 14:08:55 INFO - PROCESS | 2235 | |7;imaging-desaturate;92;94;90;126;138;91;91;93;91;92 14:08:55 INFO - PROCESS | 2235 | |8;json-parse-financial;56;59;58;59;61;60;58;70;55;55 14:08:55 INFO - PROCESS | 2235 | |9;json-stringify-tinderbox;64;72;72;73;70;69;69;65;67;67 14:08:55 INFO - PROCESS | 2235 | |10;stanford-crypto-aes;82;84;81;84;82;84;83;86;80;97 14:08:55 INFO - PROCESS | 2235 | |11;stanford-crypto-ccm;125;131;119;120;120;120;122;119;117;125 14:08:55 INFO - PROCESS | 2235 | |12;stanford-crypto-pbkdf2;135;144;136;133;137;124;137;134;133;139 14:08:55 INFO - PROCESS | 2235 | |13;stanford-crypto-sha256-iterative;67;68;68;67;67;66;64;67;66;65 14:08:55 INFO - PROCESS | 2235 | __end_tp_report 14:08:55 INFO - PROCESS | 2235 | __start_cc_report 14:08:55 INFO - PROCESS | 2235 | _x_x_mozilla_cycle_collect,939 14:08:55 INFO - PROCESS | 2235 | __end_cc_report 14:08:55 INFO - PROCESS | 2235 | __startTimestamp1461186535418__endTimestamp 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | ------- Summary: start ------- 14:08:55 INFO - PROCESS | 2235 | Number of tests: 14 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#0] ai-astar Cycles:10 Average:127.10 Median:115.50 stddev:23.82 (20.6%) stddev-sans-first:24.86 14:08:55 INFO - PROCESS | 2235 | Values: 115.0 108.0 114.0 141.0 169.0 169.0 113.0 116.0 113.0 113.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#1] audio-beat-detection Cycles:10 Average:157.30 Median:168.50 stddev:26.25 (15.6%) stddev-sans-first:27.83 14:08:55 INFO - PROCESS | 2235 | Values: 155.0 142.0 192.0 182.0 120.0 143.0 123.0 183.0 183.0 150.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#2] audio-dft Cycles:10 Average:212.60 Median:200.50 stddev:34.04 (17.0%) stddev-sans-first:35.75 14:08:55 INFO - PROCESS | 2235 | Values: 199.0 194.0 165.0 242.0 274.0 259.0 196.0 202.0 198.0 197.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#3] audio-fft Cycles:10 Average:83.10 Median:70.50 stddev:32.21 (45.7%) stddev-sans-first:33.15 14:08:55 INFO - PROCESS | 2235 | Values: 61.0 64.0 77.0 114.0 63.0 79.0 82.0 85.0 159.0 47.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:79.00 stddev:19.03 (24.1%) stddev-sans-first:20.01 14:08:55 INFO - PROCESS | 2235 | Values: 85.0 85.0 124.0 81.0 77.0 79.0 115.0 78.0 79.0 119.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#5] imaging-gaussian-blur Cycles:10 Average:105.90 Median:86.00 stddev:20.88 (24.3%) stddev-sans-first:21.44 14:08:55 INFO - PROCESS | 2235 | Values: 91.0 100.0 135.0 88.0 112.0 84.0 136.0 131.0 92.0 90.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:96.00 stddev:11.43 (11.9%) stddev-sans-first:12.06 14:08:55 INFO - PROCESS | 2235 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 100.0 90.0 131.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#7] imaging-desaturate Cycles:10 Average:99.80 Median:91.50 stddev:17.24 (18.8%) stddev-sans-first:18.06 14:08:55 INFO - PROCESS | 2235 | Values: 92.0 94.0 90.0 126.0 138.0 91.0 91.0 93.0 91.0 92.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:4.33 (7.3%) stddev-sans-first:4.45 14:08:55 INFO - PROCESS | 2235 | Values: 56.0 59.0 58.0 59.0 61.0 60.0 58.0 70.0 55.0 55.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.50 stddev:3.05 (4.4%) stddev-sans-first:2.69 14:08:55 INFO - PROCESS | 2235 | Values: 64.0 72.0 72.0 73.0 70.0 69.0 69.0 65.0 67.0 67.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:4.79 (5.7%) stddev-sans-first:5.00 14:08:55 INFO - PROCESS | 2235 | Values: 82.0 84.0 81.0 84.0 82.0 84.0 83.0 86.0 80.0 97.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:121.00 stddev:4.13 (3.4%) stddev-sans-first:4.22 14:08:55 INFO - PROCESS | 2235 | Values: 125.0 131.0 119.0 120.0 120.0 120.0 122.0 119.0 117.0 125.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.20 Median:136.50 stddev:5.12 (3.7%) stddev-sans-first:5.43 14:08:55 INFO - PROCESS | 2235 | Values: 135.0 144.0 136.0 133.0 137.0 124.0 137.0 134.0 133.0 139.0 14:08:55 INFO - PROCESS | 2235 | 14:08:55 INFO - PROCESS | 2235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.27 (1.9%) stddev-sans-first:1.33 14:08:55 INFO - PROCESS | 2235 | Values: 67.0 68.0 68.0 67.0 67.0 66.0 64.0 67.0 66.0 65.0 14:08:55 INFO - PROCESS | 2235 | -------- Summary: end -------- 14:08:55 INFO - PROCESS | 2235 | 14:08:56 INFO - TEST-INFO | 2235: exit 0 14:08:56 INFO - TEST-OK | kraken | took 58132ms 14:08:56 INFO - SUITE-END | took 1168s 14:08:56 INFO - Completed test suite (00:19:28) 14:08:56 INFO - javascript benchmark 14:08:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3146.5909431773866, 3491.2842867212225, 3505.8948231553063, 3516.1385460562165, 3549.8935031949036, 5734.627249228803, 5744.770209191638, 5763.740631671574, 5782.132680097988, 5831.446012628804, 5774.307083150017, 5785.27684039495, 5804.245448091753, 5816.738246778895, 5826.650400975945, 5143.485651434864, 5150.587952963763, 5228.0, 5271.393789714193, 5273.76268067936, 5118.744062796864, 5146.9485305146845, 5263.131583288753, 5266.447023062581, 5282.550983166436, 5232.241325007891, 5265.131253343194, 5271.0, 5272.973635131819, 5296.523312901838, 5214.243934629495, 5215.504527069922, 5226.111561034633, 5237.397699264595, 5277.683338999634, 5027.0, 5067.239914012891, 5079.593632509391, 5147.510986456281, 5168.379794424655, 5523.751431185607, 5524.033294173503, 5552.444755524456, 5565.972170139164, 5582.330120385539, 6159.938400615982, 6212.720427580724, 6230.844228894314, 6232.750689972396, 6240.126382306481, 6124.228368151221, 6166.383361663842, 6173.382661733835, 6216.533759968021, 6265.59273647216, 5874.530037596982, 5897.32180799205, 5902.734376953047, 5903.793367232126, 5914.349421563625, 6292.087647291117, 6292.433680968735, 6301.117843501914, 6303.212098487689, 6307.653079080603, 5989.341172471025, 6093.086037094471, 6123.4488895999575, 6136.886723216021, 6227.283862355887, 6211.9068213976825, 6232.875342493125, 6235.220597425322, 6254.718537665725, 6262.530310226751, 6182.258129024456, 6210.347913469021, 6227.034809604518, 6242.875142497124, 6245.875082498324, 5745.0, 5893.585539470582, 6232.56372053961, 6258.530610204253, 6267.467265282411, 4682.204025315705, 4923.77842997066, 4939.234418665041, 4950.554450099508, 4968.22992436173, 4236.639885609758, 4236.957630423718, 4378.649708023414, 4498.617617502484, 4537.251353526697, 4650.255959046604, 5790.739416726257, 5792.681402522818, 5796.449337312949, 5807.593468457252, 6220.626762394271, 6223.471004964538, 6244.687765611701, 6246.312905580383, 6250.593711408744, 5256.421793602701, 5728.198052272685, 5827.388124246893, 5834.737436815353, 5838.649681019152, 5374.811881584125, 5385.7576409061685, 5407.053765591006, 5420.0, 5449.945500545023, 6269.780557680459, 6300.117983482316, 6336.778212762531, 6338.176037115146, 6338.176037115238, 6144.201253836973, 6194.721237544231, 6199.752009919553, 6241.906371404341, 6249.625022498664, 6278.46633036197, 6307.653079080511, 6326.4622507087415, 6337.90493142594, 6340.175777149126, 6192.876142477216, 6238.438540531374, 6242.157308763259, 6244.313125556276, 6249.78129264789, 6152.723127459365, 6154.723037463235, 6202.689865506616, 6241.438270555672, 6269.247690277196, 5455.863603409946, 6138.877222455615, 6165.815025549241, 6167.198264225622, 6174.66039367839, 6156.907646385218, 6169.784057557964, 6179.907301390393, 6182.783602573888, 6188.164597779422, 5866.325372582208, 5868.061110222344, 5885.264341957255, 5976.8804623908145, 6069.3020302665755, 6132.0, 6147.600405973598, 6150.477209437248, 6170.197874276495, 6189.938100618936, 6047.206453540449, 6070.514358851369, 6080.300765411857, 6085.878282434415, 6105.0], "unit": "score", "name": "dojo.html", "value": 5706.715418309061}, {"lowerIsBetter": false, "replicates": [535.4431391352994, 607.1742430294798, 616.8895987222998, 666.5634009723631, 673.7602810828076, 39298.41052384216, 40049.19901601974, 40117.7994110029, 40228.59771402281, 40256.59743402569, 41824.0, 41964.74105776832, 42162.36756448648, 42319.36520952188, 42466.0, 9537.380070295443, 9752.561134748954, 9763.951180244088, 9797.90202097977, 9800.26498012652, 9632.903670963271, 9830.967748386423, 9875.95062024689, 9888.456134912612, 9898.554565044591, 9843.015698430172, 9865.802683946316, 9884.406935583853, 9905.0, 9917.752056198617, 9803.2157427406, 9886.901130988743, 9900.55447504864, 9904.059114384121, 9906.752331191707, 9671.70984870448, 9760.926298107202, 9807.509624518745, 9819.214462842956, 9825.312228144032, 34626.82686586576, 40746.79626601848, 41065.1786964259, 41102.38346424806, 41215.0, 3126.531020346966, 3319.3527262183884, 3381.120908563791, 3543.769654972444, 3702.4446333049987, 27470.5879411809, 27536.724632753616, 27872.860635696896, 28030.859845700845, 28569.0, 2563.3335332813417, 2737.5893615957566, 2800.7339302766204, 2801.705820888818, 2826.9293267668268, 249627.0, 287969.0, 346373.9999999975, 346432.0, 348950.25524872466, 39450.0, 48573.757131214115, 48968.75515622399, 66980.0, 68996.0, 47843.0, 47958.0, 48175.5182448178, 48203.5179648206, 48260.75869620629, 17093.572660683334, 17133.485995420157, 17223.22495487706, 17369.65260694779, 17448.91275543614, 13499.595012149652, 13598.252096134807, 13623.931880340535, 13662.590122296348, 13668.863311366758, 12525.498980040697, 15325.31036103378, 15730.606734831721, 15777.211139442981, 15890.284937177854, 6597.340265973365, 6729.461643068543, 6761.29006454325, 6762.763303284361, 6767.511147547531, 919.1819280840058, 988.7478692933399, 1039.8076355874186, 1095.3592148593002, 1139.3448766959032, 30142.84928575343, 30366.0, 30726.924557640374, 30777.0507651904, 30926.964058524118, 1128.4752590045505, 1134.3987686526154, 1139.2765593847967, 1236.2829558855842, 1274.566647339909, 15288.770668439982, 15719.292631831595, 15869.365225391086, 15913.124778137313, 15990.200489975454, 526076.0, 527348.0, 528760.0, 532269.3386533043, 533964.0, 62898.0, 63019.36980630227, 63537.0, 63774.68112659407, 64036.67981660062, 1270.2315099364937, 1523.2840564934463, 1548.3806477409125, 1552.5420001099476, 1568.4432026630382, 29977.250568735955, 30202.848985754932, 30613.034037616093, 30627.985668789275, 30880.691193087783, 53800.923981519365, 54062.45937540574, 54364.0, 54777.99999999841, 54870.451295486535, 487132.69300959806, 496510.0, 497603.0, 499738.0, 501085.0, 30714.84642576862, 34603.13492162716, 34832.30335393227, 35416.29167416689, 35738.0, 44878.0, 45222.77388613036, 46777.0, 47322.76338618285, 48240.03519929652, 32543.0, 38697.61302387053, 39257.0, 39561.60438395579, 40751.79624101861, 37943.2411351777, 38172.23655526818, 38237.0, 38967.0, 39014.609853902235, 38020.61979380171, 38869.44522219079, 38893.80553097217, 39071.80464097661, 39350.0, 33129.0, 34534.65465345415, 34727.826360868035, 34760.65239347574, 34958.65041349656, 24634.50730985406, 25096.0, 25735.871320643277, 26077.348066298495, 26361.340966475993], "unit": "score", "name": "ext.html", "value": 19677.02219735259}, {"lowerIsBetter": false, "replicates": [306.27107484187616, 328.949012903, 364.83035388544323, 381.5497712699017, 382.9674477669398, 20481.0, 21079.789202107993, 21259.149634014622, 21749.67375489365, 21779.911004449794, 20546.89726551369, 21020.684689729627, 21628.783712162913, 21683.13267469299, 22518.43703907403, 5863.442972917566, 6042.516598672096, 6047.15339852421, 6057.939420605803, 6065.0, 5007.9232964912535, 5716.885207384541, 5847.1521629363715, 5906.350301466835, 5969.671668058255, 5390.6226564140525, 5406.378266499363, 5648.237487939116, 5948.107783832416, 6032.638041717511, 5835.708214589275, 5930.169776231331, 6022.819315420545, 6119.143319935212, 6119.908201376983, 4804.783784729696, 5772.624779389326, 5824.271966004249, 5834.941650583482, 5854.414558544111, 21472.355829325144, 25935.35161620956, 26849.328766780793, 27221.638918054017, 27315.0, 2392.5214957008666, 2423.8182136339847, 2531.607600821857, 2678.3304173956512, 2828.702986186462, 10015.198784097327, 10280.0, 10438.425886576235, 10476.109530689824, 10801.081908037826, 1793.6681713882974, 1823.5896923192308, 1841.6592930307936, 1843.6404901044302, 1912.550550620603, 105807.0, 108924.45537772261, 110108.4494577522, 111568.0, 111898.0, 10087.092161705481, 11132.49903754333, 11242.695247474248, 11554.422278886022, 11620.07039436843, 14566.126032437876, 14709.896757742998, 14720.852791471949, 14752.778708319383, 14760.188189649672, 7458.291462311072, 9146.63413463454, 9149.954250228839, 9160.770980725401, 9241.445513269226, 7731.806704832312, 8172.305354044854, 9000.684976025808, 9505.5722492488, 9520.666776662783, 4123.278426275389, 4420.408652884958, 4592.471865735416, 4666.580007799314, 4720.575148236607, 1698.6178109925168, 1920.8186965016414, 1959.9706004409945, 1997.5205950571758, 2004.3285499357878, 715.692252331492, 982.2731178927543, 1082.7780305037606, 1093.639099097296, 1102.9283096598695, 20560.28039018627, 20837.062332195088, 20912.68630970537, 21006.15975360999, 21474.926253687252, 905.7463910105181, 1005.6228914157191, 1025.6102680981328, 1064.3986147826454, 1081.221520505235, 7702.576358300235, 11675.649730507928, 11722.531098756124, 11746.353950532632, 11770.646880593597, 659055.0, 659134.0, 667925.0, 677354.0, 682423.0, 103052.0, 104424.47787761013, 110471.0, 117910.0, 125953.0, 1042.7132538551807, 1046.278068133001, 1052.9473526323652, 1087.429099722652, 1089.5641743302583, 17999.1071871437, 18573.34993275283, 18819.435416937515, 18877.0, 18916.0, 37408.438873417464, 40663.78008659745, 52006.95986080333, 52734.472655272955, 53150.0, 72853.0, 80363.39273214385, 81345.0, 84496.0, 84935.575322123, 8126.878096828434, 8176.386770992318, 8378.958105209678, 8383.538905360263, 8434.198751118634, 9345.953270233606, 10376.896231037896, 12192.51229950792, 12952.611421657366, 13162.934185329395, 10669.519871605951, 10863.511141998471, 10904.291221070605, 11111.888881111085, 11119.221654484109, 10733.658292713411, 10803.297785644223, 11037.889621103686, 11128.666140015812, 11240.213185077293, 6211.13044173807, 9977.0, 10306.505556694088, 10391.792164156523, 11260.211785174959, 7050.0, 8324.29243514284, 8496.872546911678, 8545.914540854512, 8687.956560217412, 8674.78313042179, 11975.880241197476, 11992.580259690869, 12188.45151968146, 12309.692257693629], "unit": "score", "name": "jquery.html", "value": 9592.962323653936}, {"lowerIsBetter": false, "replicates": [1664.0681218517632, 1691.983080169198, 1898.2312163573758, 1975.9901200493987, 2048.0, 8260.91739082609, 8566.914330856705, 9041.186293233608, 9216.953915230422, 9252.398594091379, 8850.0, 8852.867206991885, 8884.333674974387, 8957.283417326615, 8976.192142707156, 2551.8341307815026, 2570.0876188952934, 2573.1122762646855, 2579.5614745493217, 2595.2473782603115, 2359.0210062823908, 2442.3894026493376, 2530.772230499255, 2579.8710064496795, 2586.715461299265, 2530.8228424010326, 2570.4602033572974, 2576.780973617245, 2585.663863697717, 2591.080166540879, 2570.3060173753074, 2586.043164029312, 2593.610958356243, 2595.5717306644383, 2603.06289735695, 2548.643189953408, 2560.6031065184925, 2572.884220210095, 2582.806289528293, 2589.7928165746694, 7623.275788800055, 9027.368084234105, 9031.683891063847, 9046.411983221135, 9062.954685226598, 4632.2356811126465, 5623.325200975909, 5664.603477756517, 5689.118186681071, 5755.740991655343, 3007.45865744166, 3709.3694072007825, 3730.08612889841, 3760.7179461540222, 3790.033541446941, 934.3366209990915, 1063.595833583241, 1086.6902932664152, 1092.5520536579963, 1100.8678958524947, 12362.0, 12523.311217883012, 12541.874581254162, 12578.371081445983, 12579.308138052404, 4200.4539409876525, 4364.476262848479, 4783.832565860178, 4989.326440930428, 5030.572401345853, 8588.527630980356, 10521.52653130611, 10582.994615511514, 10602.363858168535, 10627.628033018807, 5624.606277560531, 5688.345840228427, 5694.08894576874, 5736.397678243808, 5760.913586296209, 4621.214393553104, 4985.227289770091, 5124.128898087334, 5125.589952803767, 5139.074966506065, 4078.7384274286433, 4108.548059713429, 4122.732022418533, 4130.194612050681, 4146.626803587692, 1371.71879764648, 1377.7726675098697, 1391.6033930330009, 1395.1838174667932, 1402.2848347342929, 1314.4413624209865, 1427.750143724844, 1456.1408768826443, 1457.2640816387657, 1478.7929689843431, 8441.240288374076, 8460.196281353261, 8511.233988941025, 8514.403991720521, 8578.356623253281, 526.4883326075335, 529.2669652531272, 530.6709839899287, 539.8326518779191, 541.8891272890559, 6290.779822706275, 6328.873422531524, 6354.872902541923, 6396.9360306397275, 6402.903956440658, 10878.728031799268, 11242.156838237, 11293.830592541119, 11330.830037549444, 11386.544538218379, 10714.624988125533, 10975.780484390427, 11007.61473348429, 11141.944290278496, 11208.439578021067, 7226.602536860523, 8658.264047555902, 8661.220490155916, 8686.218240358272, 8748.47509149453, 7974.681012759424, 8065.0, 8127.512349259064, 8187.79530511742, 8202.302804261704, 9631.181349585084, 9757.316987810786, 9804.65683701067, 9914.20686345105, 10007.799844002933, 10027.448490333101, 10380.221483388927, 10461.843072353768, 10510.894891051297, 10526.157907367238, 7284.417246620364, 7605.88591171144, 7681.539107653559, 7747.845043098993, 7811.765647030598, 8475.279601233964, 8483.74548763538, 8544.700935467228, 8554.828903421772, 8558.614862331335, 7459.36595389398, 7717.884231736641, 7731.536107833548, 7749.263819937097, 7790.220977902164, 6897.517173797786, 7447.515911465955, 7542.660580273791, 7550.5469671819865, 7678.155402905788, 8050.5572193529915, 8126.796830079295, 8138.3082437993435, 8168.469049511763, 8176.632051557814, 7189.604571748604, 7250.709971601077, 7274.199838017708, 7323.523970941872, 7324.9633751833035, 7392.741254056083, 7440.107187137578, 7446.478746487911, 7458.067741532309, 7477.065366829146], "unit": "score", "name": "mootools.html", "value": 5017.465290376113}, {"lowerIsBetter": false, "replicates": [319.94720871056273, 341.5048180138799, 343.09936416905623, 347.5065407121887, 350.47778809573725, 5651.9152212716845, 6684.699188536515, 6804.931950680491, 6814.931850681492, 6820.965895170523, 6767.9019503953805, 6777.796666100013, 6777.966110169455, 6797.456203503721, 6812.761553345622, 4727.929081063787, 4812.25410061441, 4920.188168952119, 5011.974940125294, 5016.172331565287, 4955.231939049453, 4967.776450059738, 4974.079795237874, 5010.223415370605, 5081.314022606956, 3710.5732840723394, 4280.700350975433, 4316.179925814101, 4477.820887164526, 4972.254161875711, 4891.559759621633, 4993.500649935014, 4993.525615066581, 4995.975020124876, 4998.675086119427, 4289.4852617685765, 4298.634616057639, 4302.634276086536, 4308.870733877989, 4309.5690430956965, 5470.835874923759, 6325.430711236011, 6373.490120790326, 6574.441172500296, 6590.110335104748, 5924.377940316291, 5928.555358348141, 5951.345352011275, 5974.4921681657115, 5987.251593550806, 5789.594728369016, 5818.7672493100645, 7217.427373450176, 7231.855362892766, 7238.819029524251, 4806.951930480685, 4849.878753031167, 4853.805847766121, 4856.125897338477, 4863.27050942358, 6131.0, 7666.9616651916385, 7676.577788221645, 7678.385729141655, 7692.499987500794, 3880.611938806097, 4756.381670382828, 4784.904301913943, 4838.862867226199, 4922.1140194765285, 4880.121578115903, 4891.951080489221, 4915.115279249698, 4922.655414121049, 4927.103065319806, 5878.617889837147, 5881.735321910524, 5888.587798854125, 5892.9116063258225, 5913.05391137416, 7356.411487081021, 7361.595112268877, 7384.932218978694, 7385.519941203805, 7401.629918504161, 1680.0, 1703.5144983679593, 1707.0184643829848, 1707.9829201708073, 1709.572606848288, 1048.6434612231878, 1084.4957094950885, 1085.316250762015, 1089.455272363818, 1110.3337997201616, 6753.831154221086, 6825.522213445011, 6842.692078856463, 6860.108185935796, 6873.553219040747, 7634.541927484258, 7634.770956871303, 7638.541687498768, 7647.541147531166, 7653.5407875526535, 6630.237522684856, 6767.1202743644, 6918.308169183041, 6918.619475928872, 6932.584044957319, 4028.1540876415693, 4055.0, 4058.776767277769, 4072.6131017553284, 4074.490688663917, 7953.488837120928, 7957.880631790527, 7974.481658692166, 7979.1699984008, 8005.039395272604, 7612.467127301035, 7929.722459713882, 7934.246246606564, 7937.404694647925, 7966.442349035628, 7838.098618658813, 7863.52818830872, 7874.133845277015, 7911.881321780178, 7936.642851071716, 5754.935336962675, 7284.3808276294985, 7643.617819108911, 7697.769066928001, 7709.4603377763015, 7509.399248060033, 7509.88735168962, 7514.774556763306, 7518.624068796647, 7531.058617672791, 6543.574667646588, 7119.6084215368655, 7912.36701063925, 7915.604219789103, 7942.682292708227, 4257.4252475915355, 4807.975960120177, 4808.447028591757, 4860.92708609364, 4874.8050077997905, 7640.3505702015955, 7646.082470103624, 7663.501872378278, 7669.079710434784, 7726.227377262228, 5967.492763115184, 7349.412047036331, 7367.594782286811, 7377.668004939684, 7382.778516644509, 6385.97824348102, 7002.719891204499, 7079.256678048937, 7347.19180890091, 7386.519876208029, 7137.892931605927, 7149.034880291094, 7165.749198778226, 7176.605286709281, 7197.892031619425, 7313.744018959311, 7330.230325815713, 7330.96334518324, 7338.486305958531, 7342.3758980487255, 5855.385184555731, 6130.896438640909, 6866.965665171842, 7158.105236845395, 7174.282571742784], "unit": "score", "name": "prototype.html", "value": 5279.067272954576}, {"lowerIsBetter": false, "replicates": [652.2271108736146, 712.5617745086773, 716.3481232078813, 733.4205977277951, 799.3684988858798, 15218.23908804561, 15404.691906161897, 15483.767743483857, 15512.84487155128, 15523.611909702264, 11820.231684940494, 14420.855791442082, 14447.422103115889, 14530.636734081627, 14558.272086395664, 782.6986610155075, 962.3648392061241, 970.912617864392, 988.1650005745134, 989.9703008909744, 964.5418426247546, 970.7136394763527, 976.6825781620967, 979.56409397818, 985.1527686189871, 787.252110495032, 999.8250306196422, 1015.791762688647, 1019.1541020952628, 1026.9127124194415, 973.9610415583368, 975.4098770244042, 995.4027583449908, 996.3324572536418, 1007.8034783217275, 739.6264886232472, 761.7448154868126, 762.7406681728239, 771.7067514344569, 775.5734346109617, 15386.15376154311, 15519.146446945413, 15584.688306233926, 15689.686206275925, 15729.764053539206, 13365.331733413388, 13392.933035334858, 13451.66370840727, 13549.0, 13620.318984050857, 10241.539130739135, 10385.948070259676, 10415.427151506665, 10458.52936617854, 10530.42082685452, 3580.4092324766384, 3586.2648157127987, 3588.1926566522584, 3595.3708101082207, 3618.855245790165, 88922.66616000765, 89446.0, 90794.0, 90888.63667045, 90959.54520227422, 9748.415095094175, 9898.505074746234, 9908.504574771232, 9983.051610097029, 10003.849942250872, 23684.0, 23736.287911362688, 23744.64383034256, 23766.405839853796, 23830.88084559566, 6894.207166175854, 7024.438044956391, 7655.0, 7683.884741728879, 7724.420668449889, 4179.665626749853, 4204.642605378577, 4234.745915245096, 4285.735678025717, 4315.654747620183, 3738.2897249522503, 3768.736188466781, 3774.1319496515957, 3803.23935212953, 3815.542134943769, 680.550836447942, 690.433844247722, 699.4264702943537, 700.579652208681, 732.9413646908234, 524.9265102885599, 530.8036026670156, 596.4959609130278, 622.757124721359, 624.2134910013416, 5753.294964745729, 6044.667543285073, 6957.1651401832105, 8377.49735015901, 8384.664613415394, 527.9472052794766, 615.9784407545715, 618.8236352639476, 634.7207228819304, 660.6531570925303, 3862.2661694278, 3907.1013666856784, 3908.3160446922243, 3920.7059470539252, 4064.7357921734992, 89533.10466895248, 95856.0, 100540.0, 102163.48918255362, 102383.0, 86614.0, 86631.0, 87386.56306718425, 87885.0, 88404.6739298911, 66807.66596166987, 76843.23156768472, 76896.23103769003, 77517.0, 77858.61070694723, 7527.059117610299, 7585.975893254561, 7782.338501227459, 7963.601819909098, 8173.5504547250475, 38372.424413633256, 39197.21605567815, 48747.5125248743, 49101.263481048525, 55813.72093139508, 62346.688266558376, 72120.0, 73522.0, 75580.0, 75766.24233757812, 11488.770224595293, 11556.884431155917, 11560.884391155982, 11647.184697071123, 11831.935125838716, 11895.76208475843, 11934.104942129548, 12028.27830330183, 12377.876221237673, 12421.19262247951, 11302.83045754298, 11311.981921626764, 11757.294562326288, 11780.469878855301, 11963.581274655346, 8897.688580899638, 11050.06074483678, 11286.266392684449, 11291.943540282246, 11774.882251177378, 10900.127989760642, 11167.664970050586, 11197.72005699864, 11476.483558239732, 11655.067594592243, 9338.95330523343, 9382.202512786216, 9498.715038548855, 9568.378055426376, 9668.75828104303, 7677.30904218623, 9406.200472959876, 9696.272114783284, 9751.75620609462, 9762.0], "unit": "score", "name": "yui.html", "value": 7092.851561767726}], "name": "dromaeo_css", "value": 7662.415515180212}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 114.0, 141.0, 169.0, 169.0, 113.0, 116.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 127.1}, {"lowerIsBetter": true, "replicates": [155.0, 142.0, 192.0, 182.0, 120.0, 143.0, 123.0, 183.0, 183.0, 150.0], "unit": "score", "name": "audio-beat-detection", "value": 157.3}, {"lowerIsBetter": true, "replicates": [199.0, 194.0, 165.0, 242.0, 274.0, 259.0, 196.0, 202.0, 198.0, 197.0], "unit": "score", "name": "audio-dft", "value": 212.6}, {"lowerIsBetter": true, "replicates": [61.0, 64.0, 77.0, 114.0, 63.0, 79.0, 82.0, 85.0, 159.0, 47.0], "unit": "score", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 124.0, 81.0, 77.0, 79.0, 115.0, 78.0, 79.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 92.2}, {"lowerIsBetter": true, "replicates": [91.0, 100.0, 135.0, 88.0, 112.0, 84.0, 136.0, 131.0, 92.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 105.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 100.0, 90.0, 131.0], "unit": "score", "name": "imaging-darkroom", "value": 99.2}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 90.0, 126.0, 138.0, 91.0, 91.0, 93.0, 91.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 99.8}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 58.0, 59.0, 61.0, 60.0, 58.0, 70.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [64.0, 72.0, 72.0, 73.0, 70.0, 69.0, 69.0, 65.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 81.0, 84.0, 82.0, 84.0, 83.0, 86.0, 80.0, 97.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [125.0, 131.0, 119.0, 120.0, 120.0, 120.0, 122.0, 119.0, 117.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [135.0, 144.0, 136.0, 133.0, 137.0, 124.0, 137.0, 134.0, 133.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 67.0, 66.0, 64.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1512.8999999999999}]} 14:08:56 INFO - Return code: 0 14:08:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:08:56 ERROR - # TBPL SUCCESS # 14:08:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:08:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:08:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:08:56 INFO - 2016-04-20 14:08:56.764 screenresolution[2240:65746] starting screenresolution argv=screenresolution get 14:08:56 INFO - 2016-04-20 14:08:56.767 screenresolution[2240:65746] Display 0: 1600x1200x32@60 14:08:56 INFO - 2016-04-20 14:08:56.773 screenresolution[2241:65749] starting screenresolution argv=screenresolution list 14:08:56 INFO - Available Modes on Display 0 14:08:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:08:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:08:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:08:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:08:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:08:57 INFO - Intel Iris: 14:08:57 INFO - Chipset Model: Intel Iris 14:08:57 INFO - Type: GPU 14:08:57 INFO - Bus: Built-In 14:08:57 INFO - VRAM (Dynamic, Max): 1536 MB 14:08:57 INFO - Vendor: Intel (0x8086) 14:08:57 INFO - Device ID: 0x0a2e 14:08:57 INFO - Revision ID: 0x0009 14:08:57 INFO - Displays: 14:08:57 INFO - Display: 14:08:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:08:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:08:57 INFO - Display Serial Number: 1600x1200 60 14:08:57 INFO - Main Display: Yes 14:08:57 INFO - Mirror: Off 14:08:57 INFO - Online: Yes 14:08:57 INFO - Rotation: Supported 14:08:57 INFO - Return code: 0 14:08:57 INFO - Running post-action listener: _resource_record_post_action 14:08:57 INFO - Running post-run listener: _resource_record_post_run 14:08:58 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 102400; Write bytes: 664791552; Read time: 1; Write time: 3136 14:08:58 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 352313856; Write bytes: 352986624; Read time: 27809; Write time: 623 14:08:58 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 102400; Write bytes: 301462528; Read time: 1; Write time: 2479 14:08:58 INFO - Running post-run listener: _upload_blobber_files 14:08:58 INFO - Blob upload gear active. 14:08:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:08:58 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 14:08:58 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:08:58 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:08:58 INFO - (blobuploader) - INFO - Open directory for files ... 14:08:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:08:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:08:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:08:59 INFO - (blobuploader) - INFO - Done attempting. 14:08:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:08:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:08:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:09:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:00 INFO - (blobuploader) - INFO - Done attempting. 14:09:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:09:00 INFO - Return code: 0 14:09:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:09:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:09:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b672c1a35181feb9e5b4073025417c28cb03c52e2afd5847df4d95f49481de12c9a5377d6bc45270e1d51a76c9f35f4fc9f95a64db86c421a39e723b9d9cb67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbad19d39470fd60b9c2df0265accc523c79b56df0018042de9005e1dc05df0e2691fc162e0c326ba34cd067b8361c16d028cf5f9bda07122c4ab0debb9cf72c"} 14:09:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:09:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:09:00 INFO - Contents: 14:09:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b672c1a35181feb9e5b4073025417c28cb03c52e2afd5847df4d95f49481de12c9a5377d6bc45270e1d51a76c9f35f4fc9f95a64db86c421a39e723b9d9cb67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbad19d39470fd60b9c2df0265accc523c79b56df0018042de9005e1dc05df0e2691fc162e0c326ba34cd067b8361c16d028cf5f9bda07122c4ab0debb9cf72c"} 14:09:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:09:00 INFO - Copying logs to upload dir... 14:09:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:09:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.658401 ========= master_lag: 3.80 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-20 14:09:04.026571) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-04-20 14:09:04.030058) ========= 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.iXPRj9w0KK/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.aeTlQ028ss/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b672c1a35181feb9e5b4073025417c28cb03c52e2afd5847df4d95f49481de12c9a5377d6bc45270e1d51a76c9f35f4fc9f95a64db86c421a39e723b9d9cb67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbad19d39470fd60b9c2df0265accc523c79b56df0018042de9005e1dc05df0e2691fc162e0c326ba34cd067b8361c16d028cf5f9bda07122c4ab0debb9cf72c"} build_url:https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011713 build_url: 'https://queue.taskcluster.net/v1/task/P9cnHtGjR4avSSJ9DzVWgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b672c1a35181feb9e5b4073025417c28cb03c52e2afd5847df4d95f49481de12c9a5377d6bc45270e1d51a76c9f35f4fc9f95a64db86c421a39e723b9d9cb67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbad19d39470fd60b9c2df0265accc523c79b56df0018042de9005e1dc05df0e2691fc162e0c326ba34cd067b8361c16d028cf5f9bda07122c4ab0debb9cf72c"}' ========= master_lag: 14.96 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-04-20 14:09:19.000223) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-04-20 14:09:19.000539) ========= 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.iXPRj9w0KK/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.aeTlQ028ss/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.005413 ========= master_lag: 5.00 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-04-20 14:09:24.004574) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:09:24.007886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:09:24.646061) ========= ========= Total master_lag: 37.17 =========