builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0364 starttime: 1469139959.46 results: success (0) buildid: 20160721073758 builduid: 4b6fa33c8c4e4e3e88afae05d8690313 revision: 6688064e8ad629276830b941df87681a21b67cdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 15:25:59.457649) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 15:25:59.458029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 15:25:59.458304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 15:25:59.804510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:25:59.804803) ========= 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.3rndaFp50K/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.HuCHVXLcq7/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-21 15:25:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 30.2M=0s 2016-07-21 15:25:59 (30.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150304 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:26:00.017949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:26:00.018404) ========= 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.3rndaFp50K/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.HuCHVXLcq7/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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.025890 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:26:00.076768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 15:26:00.077106) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6688064e8ad629276830b941df87681a21b67cdc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6688064e8ad629276830b941df87681a21b67cdc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3rndaFp50K/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.HuCHVXLcq7/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-21 15:26:00,158 truncating revision to first 12 chars 2016-07-21 15:26:00,158 Setting DEBUG logging. 2016-07-21 15:26:00,158 attempt 1/10 2016-07-21 15:26:00,158 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6688064e8ad6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 15:26:01,340 unpacking tar archive at: mozilla-beta-6688064e8ad6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.476429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 15:26:01.574927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 15:26:01.575207) ========= script_repo_revision: 6688064e8ad629276830b941df87681a21b67cdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 15:26:01.575571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 15:26:01.575842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 15:26:01.593064) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-21 15:26:01.593351) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3rndaFp50K/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.HuCHVXLcq7/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:26:01 INFO - MultiFileLogger online at 20160721 15:26:01 in /builds/slave/test 15:26:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:26:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:26:01 INFO - {'append_to_log': False, 15:26:01 INFO - 'base_work_dir': '/builds/slave/test', 15:26:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:26:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:26:01 INFO - 'branch': 'Mozilla-Beta', 15:26:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:26:01 INFO - 'config_files': ('talos/mac_config.py',), 15:26:01 INFO - 'default_actions': ('clobber', 15:26:01 INFO - 'read-buildbot-config', 15:26:01 INFO - 'download-and-extract', 15:26:01 INFO - 'populate-webroot', 15:26:01 INFO - 'create-virtualenv', 15:26:01 INFO - 'install', 15:26:01 INFO - 'run-tests'), 15:26:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:26:01 INFO - 'download_minidump_stackwalk': True, 15:26:01 INFO - 'download_symbols': 'ondemand', 15:26:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:26:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:26:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:26:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:26:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:26:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:26:01 INFO - 'installer_path': 'installer.exe', 15:26:01 INFO - 'log_level': 'info', 15:26:01 INFO - 'log_name': 'talos', 15:26:01 INFO - 'log_to_console': True, 15:26:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:26:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:26:01 INFO - 'opt_config_files': (), 15:26:01 INFO - 'pip_index': False, 15:26:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:26:01 INFO - 'cmd': ('bash', 15:26:01 INFO - '-c', 15:26:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:26:01 INFO - 'enabled': True, 15:26:01 INFO - 'halt_on_failure': False, 15:26:01 INFO - 'name': 'check_screen_resolution'},), 15:26:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:26:01 INFO - 'cmd': ('bash', 15:26:01 INFO - '-c', 15:26:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:26:01 INFO - 'enabled': True, 15:26:01 INFO - 'halt_on_failure': False, 15:26:01 INFO - 'name': 'check_screen_resolution'},), 15:26:01 INFO - 'run_cmd_checks_enabled': True, 15:26:01 INFO - 'sps_profile': False, 15:26:01 INFO - 'sps_profile_interval': 0, 15:26:01 INFO - 'suite': 'dromaeojs', 15:26:01 INFO - 'system_bits': '32', 15:26:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:26:01 INFO - 'title': 't-yosemite-r7-0364', 15:26:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:26:01 INFO - 'use_talos_json': True, 15:26:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:26:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:26:01 INFO - 'work_dir': 'build'} 15:26:01 INFO - ##### 15:26:01 INFO - ##### Running clobber step. 15:26:01 INFO - ##### 15:26:01 INFO - Running pre-action listener: _resource_record_pre_action 15:26:01 INFO - Running main action method: clobber 15:26:01 INFO - rmtree: /builds/slave/test/build 15:26:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:26:03 INFO - Running post-action listener: _resource_record_post_action 15:26:03 INFO - ##### 15:26:03 INFO - ##### Running read-buildbot-config step. 15:26:03 INFO - ##### 15:26:03 INFO - Running pre-action listener: _resource_record_pre_action 15:26:03 INFO - Running main action method: read_buildbot_config 15:26:03 INFO - Using buildbot properties: 15:26:03 INFO - { 15:26:03 INFO - "project": "", 15:26:03 INFO - "product": "firefox", 15:26:03 INFO - "script_repo_revision": "production", 15:26:03 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:26:03 INFO - "repository": "", 15:26:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:26:03 INFO - "buildid": "20160721073758", 15:26:03 INFO - "pgo_build": "False", 15:26:03 INFO - "basedir": "/builds/slave/test", 15:26:03 INFO - "buildnumber": 10, 15:26:03 INFO - "slavename": "t-yosemite-r7-0364", 15:26:03 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 15:26:03 INFO - "platform": "yosemite_r7", 15:26:03 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:26:03 INFO - "branch": "mozilla-beta", 15:26:03 INFO - "repo_path": "releases/mozilla-beta", 15:26:03 INFO - "revision": "6688064e8ad629276830b941df87681a21b67cdc", 15:26:03 INFO - "stage_platform": "macosx64", 15:26:03 INFO - "builduid": "4b6fa33c8c4e4e3e88afae05d8690313", 15:26:03 INFO - "slavebuilddir": "test" 15:26:03 INFO - } 15:26:03 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.dmg. 15:26:03 INFO - Running post-action listener: _resource_record_post_action 15:26:03 INFO - ##### 15:26:03 INFO - ##### Running download-and-extract step. 15:26:03 INFO - ##### 15:26:03 INFO - Running pre-action listener: _resource_record_pre_action 15:26:03 INFO - Running main action method: download_and_extract 15:26:03 INFO - mkdir: /builds/slave/test/build/tests 15:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.test_packages.json 15:26:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 15:26:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 15:26:04 INFO - Downloaded 1165 bytes. 15:26:04 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 15:26:04 INFO - Using the following test package requirements: 15:26:04 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 15:26:04 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:26:04 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 15:26:04 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:26:04 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 15:26:04 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:26:04 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:26:04 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 15:26:04 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 15:26:04 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:26:04 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 15:26:04 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:26:04 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 15:26:04 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:26:04 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 15:26:04 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:26:04 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 15:26:04 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 15:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:04 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.common.tests.zip 15:26:04 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 15:26:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 15:26:05 INFO - Downloaded 18314909 bytes. 15:26:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:26:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:26:08 INFO - Return code: 0 15:26:08 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:26: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')]} 15:26:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.common.tests.zip 15:26:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 15:26:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 15:26:09 INFO - Downloaded 18314909 bytes. 15:26:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:26:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:26:13 INFO - Return code: 0 15:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:13 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.talos.tests.zip 15:26:13 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 15:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 15:26:14 INFO - Downloaded 10840145 bytes. 15:26:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:26:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:26:14 INFO - Return code: 0 15:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.dmg 15:26:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 15:26:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 15:26:19 INFO - Downloaded 86192089 bytes. 15:26:19 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.dmg 15:26:19 INFO - mkdir: /builds/slave/test/properties 15:26:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:26:19 INFO - Writing to file /builds/slave/test/properties/build_url 15:26:19 INFO - Contents: 15:26:19 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.dmg 15:26:19 INFO - Running post-action listener: _resource_record_post_action 15:26:19 INFO - Running post-action listener: set_extra_try_arguments 15:26:19 INFO - ##### 15:26:19 INFO - ##### Running populate-webroot step. 15:26:19 INFO - ##### 15:26:19 INFO - Running pre-action listener: _resource_record_pre_action 15:26:19 INFO - Running main action method: populate_webroot 15:26:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:26:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:26:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:26:19 INFO - '--tppagecycles', 15:26:19 INFO - '7'], 15:26:19 INFO - 'tests': ['tsvgm']}}, 15:26:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:26:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:26:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:26:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:26:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:26:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:26:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:19 INFO - 'talos_options': ['--disable-e10s'], 15:26:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:19 INFO - 'talos_options': ['--disable-e10s'], 15:26:19 INFO - 'tests': ['damp', 'tps']}, 15:26:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:19 INFO - 'tests': ['damp', 'tps']}, 15:26:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:26:19 INFO - 'tests': ['dromaeo_dom']}, 15:26:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:26:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:26:19 INFO - 'tests': ['a11yr', 15:26:19 INFO - 'ts_paint', 15:26:19 INFO - 'tpaint', 15:26:19 INFO - 'sessionrestore', 15:26:19 INFO - 'sessionrestore_no_auto_restore', 15:26:19 INFO - 'tabpaint']}, 15:26:19 INFO - 'other-e10s': {'tests': ['a11yr', 15:26:19 INFO - 'ts_paint', 15:26:19 INFO - 'tpaint', 15:26:19 INFO - 'sessionrestore', 15:26:19 INFO - 'sessionrestore_no_auto_restore', 15:26:19 INFO - 'tabpaint']}, 15:26:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:26:19 INFO - 'ts_paint', 15:26:19 INFO - 'tpaint', 15:26:19 INFO - 'sessionrestore', 15:26:19 INFO - 'sessionrestore_no_auto_restore', 15:26:19 INFO - 'tabpaint']}, 15:26:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:26:19 INFO - 'ts_paint', 15:26:19 INFO - 'tpaint', 15:26:19 INFO - 'sessionrestore', 15:26:19 INFO - 'sessionrestore_no_auto_restore', 15:26:19 INFO - 'tabpaint']}, 15:26:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:26:19 INFO - 'tests': ['a11yr', 15:26:19 INFO - 'ts_paint', 15:26:19 INFO - 'tpaint', 15:26:19 INFO - 'sessionrestore', 15:26:19 INFO - 'sessionrestore_no_auto_restore', 15:26:19 INFO - 'tabpaint']}, 15:26:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:26:19 INFO - 'tests': ['a11yr', 15:26:19 INFO - 'ts_paint', 15:26:19 INFO - 'tpaint', 15:26:19 INFO - 'sessionrestore', 15:26:19 INFO - 'sessionrestore_no_auto_restore', 15:26:19 INFO - 'tabpaint']}, 15:26:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:26:19 INFO - 'tests': ['tsvgx', 15:26:19 INFO - 'tsvgr_opacity', 15:26:19 INFO - 'tart', 15:26:19 INFO - 'tscrollx', 15:26:19 INFO - 'cart']}, 15:26:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:26:19 INFO - 'tsvgr_opacity', 15:26:19 INFO - 'tart', 15:26:19 INFO - 'tscrollx', 15:26:19 INFO - 'cart']}, 15:26:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:19 INFO - 'talos_options': ['--disable-e10s'], 15:26:19 INFO - 'tests': ['tp5o']}, 15:26:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:19 INFO - 'tests': ['tp5o']}, 15:26:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:19 INFO - 'talos_options': ['--disable-e10s', 15:26:19 INFO - '--xperf_path', 15:26:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:19 INFO - 'tests': ['tp5n']}, 15:26:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:19 INFO - 'talos_options': ['--xperf_path', 15:26:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:19 INFO - 'tests': ['tp5n']}}, 15:26:19 INFO - 'talos.zip': {'path': '', 15:26:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:26:19 INFO - Running post-action listener: _resource_record_post_action 15:26:19 INFO - ##### 15:26:19 INFO - ##### Running create-virtualenv step. 15:26:19 INFO - ##### 15:26:19 INFO - Running pre-action listener: _resource_record_pre_action 15:26:19 INFO - Running main action method: create_virtualenv 15:26:19 INFO - Creating virtualenv /builds/slave/test/build/venv 15:26:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:26:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:26:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:26:19 INFO - Using real prefix '/tools/python27' 15:26:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:26:20 INFO - Installing distribute.............................................................................................................................................................................................done. 15:26:23 INFO - Installing pip.................done. 15:26:23 INFO - Return code: 0 15:26:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:23 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 0x102000a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a70d6c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e9fe00>, '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 0x101d08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e9ab20>, '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.3rndaFp50K/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.HuCHVXLcq7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:26:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rndaFp50K/Render', 15:26:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:23 INFO - 'HOME': '/Users/cltbld', 15:26:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:23 INFO - 'LOGNAME': 'cltbld', 15:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:23 INFO - 'MOZ_NO_REMOTE': '1', 15:26:23 INFO - 'NO_EM_RESTART': '1', 15:26:23 INFO - 'PAGER': '/bin/cat', 15:26:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:23 INFO - 'PWD': '/builds/slave/test', 15:26:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:23 INFO - 'SHELL': '/bin/bash', 15:26:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuCHVXLcq7/Listeners', 15:26:23 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 15:26:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:23 INFO - 'USER': 'cltbld', 15:26:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:23 INFO - 'XPC_FLAGS': '0x0', 15:26:23 INFO - 'XPC_SERVICE_NAME': '0', 15:26:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:26:23 INFO - Cleaning up... 15:26:23 INFO - Return code: 0 15:26:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:23 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 0x102000a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a70d6c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e9fe00>, '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 0x101d08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e9ab20>, '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.3rndaFp50K/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.HuCHVXLcq7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:26:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rndaFp50K/Render', 15:26:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:23 INFO - 'HOME': '/Users/cltbld', 15:26:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:23 INFO - 'LOGNAME': 'cltbld', 15:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:23 INFO - 'MOZ_NO_REMOTE': '1', 15:26:23 INFO - 'NO_EM_RESTART': '1', 15:26:23 INFO - 'PAGER': '/bin/cat', 15:26:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:23 INFO - 'PWD': '/builds/slave/test', 15:26:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:23 INFO - 'SHELL': '/bin/bash', 15:26:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuCHVXLcq7/Listeners', 15:26:23 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 15:26:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:23 INFO - 'USER': 'cltbld', 15:26:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:23 INFO - 'XPC_FLAGS': '0x0', 15:26:23 INFO - 'XPC_SERVICE_NAME': '0', 15:26:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:23 INFO - Downloading/unpacking psutil>=0.7.1 15:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:26:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:27 INFO - Installing collected packages: psutil 15:26:27 INFO - Running setup.py install for psutil 15:26:27 INFO - building 'psutil._psutil_osx' extension 15:26:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:26:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:26:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:26:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:26:28 INFO - building 'psutil._psutil_posix' extension 15:26:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:26:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:26:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:26:28 INFO - ^ 15:26:28 INFO - 1 warning generated. 15:26:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:26:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:28 INFO - Successfully installed psutil 15:26:28 INFO - Cleaning up... 15:26:28 INFO - Return code: 0 15:26:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102000a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a70d6c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e9fe00>, '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 0x101d08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e9ab20>, '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.3rndaFp50K/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.HuCHVXLcq7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:26:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rndaFp50K/Render', 15:26:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:28 INFO - 'HOME': '/Users/cltbld', 15:26:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:28 INFO - 'LOGNAME': 'cltbld', 15:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:28 INFO - 'MOZ_NO_REMOTE': '1', 15:26:28 INFO - 'NO_EM_RESTART': '1', 15:26:28 INFO - 'PAGER': '/bin/cat', 15:26:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:28 INFO - 'PWD': '/builds/slave/test', 15:26:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:28 INFO - 'SHELL': '/bin/bash', 15:26:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuCHVXLcq7/Listeners', 15:26:28 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 15:26:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:28 INFO - 'USER': 'cltbld', 15:26:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:28 INFO - 'XPC_FLAGS': '0x0', 15:26:28 INFO - 'XPC_SERVICE_NAME': '0', 15:26:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:26:31 INFO - Installing collected packages: mozsystemmonitor 15:26:31 INFO - Running setup.py install for mozsystemmonitor 15:26:31 INFO - Successfully installed mozsystemmonitor 15:26:31 INFO - Cleaning up... 15:26:31 INFO - Return code: 0 15:26:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:31 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 0x102000a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a70d6c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e9fe00>, '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 0x101d08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e9ab20>, '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.3rndaFp50K/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.HuCHVXLcq7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:26:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rndaFp50K/Render', 15:26:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:31 INFO - 'HOME': '/Users/cltbld', 15:26:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:31 INFO - 'LOGNAME': 'cltbld', 15:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:31 INFO - 'MOZ_NO_REMOTE': '1', 15:26:31 INFO - 'NO_EM_RESTART': '1', 15:26:31 INFO - 'PAGER': '/bin/cat', 15:26:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:31 INFO - 'PWD': '/builds/slave/test', 15:26:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:31 INFO - 'SHELL': '/bin/bash', 15:26:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuCHVXLcq7/Listeners', 15:26:31 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 15:26:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:31 INFO - 'USER': 'cltbld', 15:26:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:31 INFO - 'XPC_FLAGS': '0x0', 15:26:31 INFO - 'XPC_SERVICE_NAME': '0', 15:26:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:32 INFO - Downloading/unpacking blobuploader==1.2.4 15:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:26:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:26:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:35 INFO - Downloading docopt-0.6.1.tar.gz 15:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:26:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:26:35 INFO - Running setup.py install for blobuploader 15:26:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:26:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:26:36 INFO - Running setup.py install for requests 15:26:36 INFO - Running setup.py install for docopt 15:26:36 INFO - Successfully installed blobuploader requests docopt 15:26:36 INFO - Cleaning up... 15:26:36 INFO - Return code: 0 15:26:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:36 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 0x102000a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a70d6c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e9fe00>, '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 0x101d08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e9ab20>, '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.3rndaFp50K/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.HuCHVXLcq7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:26:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:26:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:26:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rndaFp50K/Render', 15:26:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:36 INFO - 'HOME': '/Users/cltbld', 15:26:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:36 INFO - 'LOGNAME': 'cltbld', 15:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:36 INFO - 'MOZ_NO_REMOTE': '1', 15:26:36 INFO - 'NO_EM_RESTART': '1', 15:26:36 INFO - 'PAGER': '/bin/cat', 15:26:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:36 INFO - 'PWD': '/builds/slave/test', 15:26:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:36 INFO - 'SHELL': '/bin/bash', 15:26:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuCHVXLcq7/Listeners', 15:26:36 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 15:26:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:36 INFO - 'USER': 'cltbld', 15:26:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:36 INFO - 'XPC_FLAGS': '0x0', 15:26:36 INFO - 'XPC_SERVICE_NAME': '0', 15:26:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:26:37 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-2Hswna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:26:37 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-DDJAqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:26:37 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Oy9JUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:26:37 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-VP4fya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:26:37 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-2Q6wRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:26:37 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-HKwyOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:26:37 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-DDZlc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:26:37 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-IO_Xgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:26:37 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-9DmFiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:26:37 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-rFshtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:26:38 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-29IJJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:26:38 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-C72pzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:26:38 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-mL8r1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:26:38 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-ipCvkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:38 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-7GUH6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:26:38 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-1qtNsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:26:38 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-FkCGd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:26:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:26:38 INFO - Running setup.py install for manifestparser 15:26:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:26:38 INFO - Running setup.py install for mozcrash 15:26:39 INFO - Running setup.py install for mozdebug 15:26:39 INFO - Running setup.py install for mozdevice 15:26:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:26:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:26:39 INFO - Running setup.py install for mozfile 15:26:39 INFO - Running setup.py install for mozhttpd 15:26:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:26:39 INFO - Running setup.py install for mozinfo 15:26:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:26:39 INFO - Running setup.py install for mozInstall 15:26:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:26:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:26:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:26:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:26:39 INFO - Running setup.py install for mozleak 15:26:40 INFO - Running setup.py install for mozlog 15:26:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:26:40 INFO - Running setup.py install for moznetwork 15:26:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:26:40 INFO - Running setup.py install for mozprocess 15:26:40 INFO - Running setup.py install for mozprofile 15:26:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:26:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:26:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:26:40 INFO - Running setup.py install for mozrunner 15:26:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:26:40 INFO - Running setup.py install for mozscreenshot 15:26:40 INFO - Running setup.py install for moztest 15:26:41 INFO - Running setup.py install for mozversion 15:26:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:26:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:26:41 INFO - Cleaning up... 15:26:41 INFO - Return code: 0 15:26:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:41 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 0x102000a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a70d6c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e9fe00>, '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 0x101d08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e9ab20>, '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.3rndaFp50K/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.HuCHVXLcq7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:26:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rndaFp50K/Render', 15:26:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:41 INFO - 'HOME': '/Users/cltbld', 15:26:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:41 INFO - 'LOGNAME': 'cltbld', 15:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:41 INFO - 'MOZ_NO_REMOTE': '1', 15:26:41 INFO - 'NO_EM_RESTART': '1', 15:26:41 INFO - 'PAGER': '/bin/cat', 15:26:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:41 INFO - 'PWD': '/builds/slave/test', 15:26:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:41 INFO - 'SHELL': '/bin/bash', 15:26:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuCHVXLcq7/Listeners', 15:26:41 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 15:26:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:41 INFO - 'USER': 'cltbld', 15:26:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:41 INFO - 'XPC_FLAGS': '0x0', 15:26:41 INFO - 'XPC_SERVICE_NAME': '0', 15:26:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:26:41 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-onfXpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:26:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:26:41 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-t_0DV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:26:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:26:41 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-FGjnDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:26:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:26:41 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-GumcvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:26:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:26:42 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-okAGbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:26:42 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Fx9xPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:26:42 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-pW9tgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:26:42 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-GuYfPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:26:42 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-d0UY2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:26:42 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-E07aC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:26:42 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-TaNc70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:26:42 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-wEzbB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:26:42 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Zsqu9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:26:42 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-NCfNaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:43 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-1LpwOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:26:43 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-8UvmF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:26:43 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-h4qJ4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:26:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:45 INFO - Downloading blessings-1.6.tar.gz 15:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:26:45 INFO - Installing collected packages: blessings 15:26:45 INFO - Running setup.py install for blessings 15:26:46 INFO - Successfully installed blessings 15:26:46 INFO - Cleaning up... 15:26:46 INFO - Return code: 0 15:26:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:26:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:26:46 INFO - Reading from file tmpfile_stdout 15:26:46 INFO - Current package versions: 15:26:46 INFO - blessings == 1.6 15:26:46 INFO - blobuploader == 1.2.4 15:26:46 INFO - docopt == 0.6.1 15:26:46 INFO - manifestparser == 1.1 15:26:46 INFO - mozInstall == 1.12 15:26:46 INFO - mozcrash == 0.17 15:26:46 INFO - mozdebug == 0.1 15:26:46 INFO - mozdevice == 0.48 15:26:46 INFO - mozfile == 1.2 15:26:46 INFO - mozhttpd == 0.7 15:26:46 INFO - mozinfo == 0.9 15:26:46 INFO - mozleak == 0.1 15:26:46 INFO - mozlog == 3.1 15:26:46 INFO - moznetwork == 0.27 15:26:46 INFO - mozprocess == 0.22 15:26:46 INFO - mozprofile == 0.28 15:26:46 INFO - mozrunner == 6.11 15:26:46 INFO - mozscreenshot == 0.1 15:26:46 INFO - mozsystemmonitor == 0.0 15:26:46 INFO - moztest == 0.7 15:26:46 INFO - mozversion == 1.4 15:26:46 INFO - psutil == 3.1.1 15:26:46 INFO - requests == 1.2.3 15:26:46 INFO - wsgiref == 0.1.2 15:26:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:46 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 0x102000a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a70d6c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e9fe00>, '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 0x101d08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e9ab20>, '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.3rndaFp50K/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.HuCHVXLcq7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rndaFp50K/Render', 15:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:46 INFO - 'HOME': '/Users/cltbld', 15:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:46 INFO - 'LOGNAME': 'cltbld', 15:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:46 INFO - 'MOZ_NO_REMOTE': '1', 15:26:46 INFO - 'NO_EM_RESTART': '1', 15:26:46 INFO - 'PAGER': '/bin/cat', 15:26:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:46 INFO - 'PWD': '/builds/slave/test', 15:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:46 INFO - 'SHELL': '/bin/bash', 15:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuCHVXLcq7/Listeners', 15:26:46 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 15:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:46 INFO - 'USER': 'cltbld', 15:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:46 INFO - 'XPC_FLAGS': '0x0', 15:26:46 INFO - 'XPC_SERVICE_NAME': '0', 15:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:26:46 INFO - Cleaning up... 15:26:46 INFO - Return code: 0 15:26:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:46 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 0x102000a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a70d6c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e9fe00>, '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 0x101d08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e9ab20>, '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.3rndaFp50K/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.HuCHVXLcq7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rndaFp50K/Render', 15:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:46 INFO - 'HOME': '/Users/cltbld', 15:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:46 INFO - 'LOGNAME': 'cltbld', 15:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:46 INFO - 'MOZ_NO_REMOTE': '1', 15:26:46 INFO - 'NO_EM_RESTART': '1', 15:26:46 INFO - 'PAGER': '/bin/cat', 15:26:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:46 INFO - 'PWD': '/builds/slave/test', 15:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:46 INFO - 'SHELL': '/bin/bash', 15:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuCHVXLcq7/Listeners', 15:26:46 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 15:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:46 INFO - 'USER': 'cltbld', 15:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:46 INFO - 'XPC_FLAGS': '0x0', 15:26:46 INFO - 'XPC_SERVICE_NAME': '0', 15:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:46 INFO - Downloading/unpacking jsonschema 15:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:26:49 INFO - Downloading/unpacking functools32 (from jsonschema) 15:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:49 INFO - Downloading functools32-3.2.3-2.tar.gz 15:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:26:49 INFO - warning: no files found matching '*.txt' 15:26:49 INFO - no previously-included directories found matching 'build' 15:26:49 INFO - no previously-included directories found matching 'dist' 15:26:49 INFO - no previously-included directories found matching '.git*' 15:26:50 INFO - Installing collected packages: jsonschema, functools32 15:26:50 INFO - Running setup.py install for functools32 15:26:50 INFO - warning: no files found matching '*.txt' 15:26:50 INFO - no previously-included directories found matching 'build' 15:26:50 INFO - no previously-included directories found matching 'dist' 15:26:50 INFO - no previously-included directories found matching '.git*' 15:26:50 INFO - Successfully installed jsonschema functools32 15:26:50 INFO - Cleaning up... 15:26:50 INFO - Return code: 0 15:26:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:50 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 0x102000a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a70d6c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e9fe00>, '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 0x101d08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e9ab20>, '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.3rndaFp50K/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.HuCHVXLcq7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:26:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:26:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rndaFp50K/Render', 15:26:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:50 INFO - 'HOME': '/Users/cltbld', 15:26:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:50 INFO - 'LOGNAME': 'cltbld', 15:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:50 INFO - 'MOZ_NO_REMOTE': '1', 15:26:50 INFO - 'NO_EM_RESTART': '1', 15:26:50 INFO - 'PAGER': '/bin/cat', 15:26:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:50 INFO - 'PWD': '/builds/slave/test', 15:26:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:50 INFO - 'SHELL': '/bin/bash', 15:26:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuCHVXLcq7/Listeners', 15:26:50 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 15:26:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:50 INFO - 'USER': 'cltbld', 15:26:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:50 INFO - 'XPC_FLAGS': '0x0', 15:26:50 INFO - 'XPC_SERVICE_NAME': '0', 15:26:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:50 INFO - Downloading/unpacking flake8 15:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:26:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:26:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:26:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:26:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:26:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:26:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:26:54 INFO - no previously-included directories found matching 'docs/_build' 15:26:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:26:54 INFO - Running setup.py install for pep8 15:26:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:26:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:26:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:26:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:26:54 INFO - no previously-included directories found matching 'docs/_build' 15:26:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:26:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:26:54 INFO - Cleaning up... 15:26:54 INFO - Return code: 0 15:26:54 INFO - Running post-action listener: _resource_record_post_action 15:26:54 INFO - Running post-action listener: _start_resource_monitoring 15:26:54 INFO - Starting resource monitoring. 15:26:54 INFO - ##### 15:26:54 INFO - ##### Running install step. 15:26:54 INFO - ##### 15:26:54 INFO - Running pre-action listener: _resource_record_pre_action 15:26:54 INFO - Running main action method: install 15:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:26:54 INFO - Reading from file tmpfile_stdout 15:26:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:26:54 INFO - Reading from file tmpfile_stdout 15:26:54 INFO - Output received: 15:26:54 INFO - Usage: mozinstall [options] installer 15:26:54 INFO - Options: 15:26:54 INFO - -h, --help show this help message and exit 15:26:54 INFO - -d DEST, --destination=DEST 15:26:54 INFO - Directory to install application into. [default: 15:26:54 INFO - "/builds/slave/test"] 15:26:54 INFO - --app=APP Application being installed. [default: firefox] 15:26:54 INFO - mkdir: /builds/slave/test/build/application 15:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:27:16 INFO - Reading from file tmpfile_stdout 15:27:16 INFO - Output received: 15:27:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:27:16 INFO - Running post-action listener: _resource_record_post_action 15:27:16 INFO - ##### 15:27:16 INFO - ##### Running run-tests step. 15:27:16 INFO - ##### 15:27:16 INFO - Running pre-action listener: _resource_record_pre_action 15:27:16 INFO - Running main action method: run_tests 15:27:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:27:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:27:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:27:16 INFO - 2016-07-21 15:27:16.813 screenresolution[1648:8277] starting screenresolution argv=screenresolution get 15:27:16 INFO - 2016-07-21 15:27:16.815 screenresolution[1648:8277] Display 0: 1600x1200x32@60 15:27:16 INFO - 2016-07-21 15:27:16.821 screenresolution[1649:8280] starting screenresolution argv=screenresolution list 15:27:16 INFO - Available Modes on Display 0 15:27:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:27:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:27:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:27:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:27:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:27:17 INFO - Intel Iris: 15:27:17 INFO - Chipset Model: Intel Iris 15:27:17 INFO - Type: GPU 15:27:17 INFO - Bus: Built-In 15:27:17 INFO - VRAM (Dynamic, Max): 1536 MB 15:27:17 INFO - Vendor: Intel (0x8086) 15:27:17 INFO - Device ID: 0x0a2e 15:27:17 INFO - Revision ID: 0x0009 15:27:17 INFO - Displays: 15:27:17 INFO - Display: 15:27:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:27:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:27:17 INFO - Display Serial Number: 1600x1200 60 15:27:17 INFO - Main Display: Yes 15:27:17 INFO - Mirror: Off 15:27:17 INFO - Online: Yes 15:27:17 INFO - Rotation: Supported 15:27:17 INFO - Return code: 0 15:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:27:17 INFO - Python 2.7.3 15:27:17 INFO - Return code: 0 15:27:17 INFO - grabbing minidump binary from tooltool 15:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e9fe00>, '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 0x101d08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e9ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:27:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:27:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:27:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:27:17 INFO - Return code: 0 15:27:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:27:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:27:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:27:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:27:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:27:18 INFO - Return code: 0 15:27:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0364', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0364 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3rndaFp50K/Render', 15:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:18 INFO - 'HOME': '/Users/cltbld', 15:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:18 INFO - 'LOGNAME': 'cltbld', 15:27:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:27:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:18 INFO - 'MOZ_NO_REMOTE': '1', 15:27:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:27:18 INFO - 'NO_EM_RESTART': '1', 15:27:18 INFO - 'PAGER': '/bin/cat', 15:27:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:18 INFO - 'PWD': '/builds/slave/test', 15:27:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:18 INFO - 'SHELL': '/bin/bash', 15:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuCHVXLcq7/Listeners', 15:27:18 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 15:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:18 INFO - 'USER': 'cltbld', 15:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:18 INFO - 'XPC_FLAGS': '0x0', 15:27:18 INFO - 'XPC_SERVICE_NAME': '0', 15:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0364', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:27:18 INFO - mozversion application_buildid: 20160721073758 15:27:18 INFO - mozversion application_changeset: 6688064e8ad629276830b941df87681a21b67cdc 15:27:18 INFO - mozversion application_display_name: Firefox 15:27:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:27:18 INFO - mozversion application_name: Firefox 15:27:18 INFO - mozversion application_remotingname: firefox 15:27:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:27:18 INFO - mozversion application_vendor: Mozilla 15:27:18 INFO - mozversion application_version: 48.0 15:27:18 INFO - mozversion platform_buildid: 20160721073758 15:27:18 INFO - mozversion platform_changeset: 6688064e8ad629276830b941df87681a21b67cdc 15:27:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:27:18 INFO - mozversion platform_version: 48.0 15:27:18 INFO - using testdate: 1469140038 15:27:18 INFO - actual date: 1469140038 15:27:18 INFO - starting webserver on 'localhost:49275' 15:27:18 INFO - SUITE-START | Running 2 tests 15:27:18 INFO - TEST-START | dromaeo_css 15:27:18 INFO - operating with platform_type : mac_ 15:27:18 INFO - Initialising browser for dromaeo_css test... 15:27:18 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmpj4NX8_/profile http://localhost:49275/getInfo.html) 15:27:20 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 15:27:20 INFO - PROCESS | 1667 | colorDepth:24 15:27:20 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 15:27:20 INFO - PROCESS | 1667 | __metrics 15:27:20 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:27:20 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:27:21 INFO - TEST-INFO | 1667: exit 0 15:27:21 INFO - Browser initialized. 15:27:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:27:21 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmpj4NX8_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:33 INFO - PROCESS | 1671 | RSS: Main: 160210944 15:27:33 INFO - PROCESS | 1671 | 15:28:24 INFO - PROCESS | 1671 | 1469140104369 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:30:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 15:30:35 INFO - PROCESS | 1671 | RSS: Main: 270389248 15:30:35 INFO - PROCESS | 1671 | 15:33:38 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 15:33:39 INFO - PROCESS | 1671 | RSS: Main: 310747136 15:33:39 INFO - PROCESS | 1671 | 15:36:40 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 15:36:41 INFO - PROCESS | 1671 | RSS: Main: 310575104 15:36:41 INFO - PROCESS | 1671 | 15:39:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 15:39:44 INFO - PROCESS | 1671 | RSS: Main: 310968320 15:39:44 INFO - PROCESS | 1671 | 15:42:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 15:42:48 INFO - PROCESS | 1671 | RSS: Main: 278814720 15:42:48 INFO - PROCESS | 1671 | 15:45:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 15:45:50 INFO - PROCESS | 1671 | RSS: Main: 316813312 15:45:50 INFO - PROCESS | 1671 | 15:45:50 INFO - PROCESS | 1671 | __start_tp_report 15:45:50 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 15:45:50 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 15:45:50 INFO - PROCESS | 1671 | |i|pagename|runs| 15:45:50 INFO - PROCESS | 1671 | |0;dojo.html;2939.470895238857;3574.3566158091535;3610.9097272568197;3657.41481362982;3666.3034023535524;5906.232189815323;5934.495567876736;5952.255968003999;5972.880542389161;5984.371640977694;5962.314333851608;6009.909851352233;6012.458878700927;6014.188084608577;6026.276846778382;5295.28513650658;5343.1985202219685;5411.972940135293;5416.83749487516;5454.072807622713;5406.648567843097;5450.345958484968;5457.808976685797;5457.972710136463;5462.371827239858;5366.517013468807;5403.405625381224;5408.621396502246;5418.756155972971;5433.375161856397;5372.328458942632;5402.459754024605;5434.728263586805;5441.863953401157;5489.6980666063355;5214.113600687854;5280.287161233223;5352.143657014898;5354.812581559627;5373.811916582901;5783.958887400267;5796.159556864273;5854.20968169296;5863.208466856962;5913.822585322448;6261.7182226799905;6280.654563998978;6287.811365659038;6299.905501417483;6304.905426418607;6203.286622038433;6289.245290565115;6339.1442155308905;6360.936390636127;6378.107065010902;6030.96984515079;6061.393860613947;6082.239720034996;6088.847778805565;6108.539925731085;6426;6429.6142231466265;6431.196100487439;6433.613983161025;6443;6196.628202307876;6309.14826498426;6314.747410103544;6327.905081423783;6345.49236061114;6188.195534580565;6288.874222515616;6333.240011198685;6341.3341599132345;6360.141380913517;6319.747210111636;6343.492520598341;6346.397092276226;6356;6377.71300291488;6262.937370626327;6282.591631543935;6298.118263443122;6318.241810982711;6324.988001919763;4989.326440930428;5038.0931432341795;5048.0913435581215;5048.848534543969;5050.242463630485;4527.9547204527535;4567.748773817406;4583.793729282191;4610.308453731967;4622.121796858653;5955.493783028491;6016.42843929826;6032.125341825411;6043.486303664238;6043.7884674036195;6349.428551430394;6355.61866288015;6358.586691865014;6358.904616430665;6370.362963703686;5850.736716847752;5932.110183472428;5953.583249172516;5995.730192141364;6014.7594096236535;5546.77812887488;5576.637518561281;5604.187392828098;5632.859178520488;5636.4927156556105;6469.902951455732;6485.870282594322;6503.902441463382;6506.674666266762;6527.249366322933;6336.049592561153;6346.841328966812;6355.968220159055;6357.93642063592;6358.936410635834;6370.426661600478;6471.741130354733;6491.318411566906;6506.284308725942;6509.544331896722;6284;6291.874162516816;6296.622202667854;6305.5901366411035;6314.273858506147;6184.690765461619;6302.275238347649;6308.684565771601;6314.6842657866;6326.746930122744;6185.165002724574;6189.752409903554;6326.525510586633;6327.462165715966;6333.334999824952;6250.218722659668;6271.404216599416;6286.905696414466;6294.937050629435;6312;6072.908906366496;6090.786822461193;6225.408586184305;6230.813075607739;6244.063390491463;6206.689665516797;6309.085182648399;6314.336994615499;6315.936840631535;6320.241571011508;6182.629042257479;6217.440430361289;6238;6242.219722534684;6249.531285153723 15:45:50 INFO - PROCESS | 1671 | |1;ext.html;539.9730013499324;560.6075746977116;570.5891757934287;586.9853253668658;639.9552031357807;28694.282642933937;39004;40037.79981100091;40053.7997310013;40128.39807402884;38611.806940965325;42828.71513854581;42952;43279.78360108195;43318.133637327235;8830.779230519223;9562.904370956288;9761.414315141079;9791.853122203172;9792.412455252672;8971.013188549254;9083;11755.941220293887;11981.580644677439;12002.219855709394;11583.247088939233;11659.183857130005;11677.357745324003;11693.239939403955;11700.765984680302;11645.941770291136;11661.591844285495;11738.413079345999;11742.706432339175;11750.353730544817;11399;11512.654620361403;11515.021223196038;11517.48171332292;11529.711757206052;39253.01867453308;41940.79029604863;42068.37247902728;42129.789351053354;42164.78917605423;3488.1628409181867;3568.2863427314383;3607.8917632471066;3971.245463361952;3995.081131339779;29098.854505727548;29595.70404295951;29792.404151917057;30213.848930755204;31117.844410778027;2758.2828464599347;2782.8469434181316;2802.565602331642;2864.7135286471394;2890.4941635213963;327498;331968;332068;332253.6774632247;332397;36910.630893691254;37395.62604373921;37444;37471.62528374736;67212.66393668098;35967;36226;36330.45504317437;36338.63661363405;36401.90794276176;16241.944273622177;16380.508584742476;16384.83615163833;16385.672286554203;16417.753733694004;12708.809367859489;13029.413676384396;13948.86051139496;14018.299085045706;14088.43646254159;8327.541985190752;8400.41197116196;8421.368397370221;8454.87317690235;8460.561704510248;3440.2775417162175;3485.5817301923425;3496.650334966534;3499.16020155166;3508.3509550733197;853.3343991686495;996.875390576178;1027.3733022856052;1093.1691914145306;1181.5687274145048;30841.537376939363;30934.090954087605;30981.380372392425;31105.68894311073;31634;1132.774098895674;1138.7210133517342;1153.9826902596467;1216.9148159628742;1291.5479582146174;15420.460283890234;15684.68630627381;15795.526134215992;15958.92020539913;16058.197090145446;652908;656836;662022;662733;663121;63334.366656332844;64023.67988160122;64125.67937160284;64144.35855641477;64187;1392.324722509582;1496.0051565708682;1513.3643869574805;1515.5756388211319;1557.7429724095398;28633.856830715715;30995.535066974466;31014.844925775225;31219.687803121677;31636.050918472483;52154.739226305144;52397;52626.73686631543;52736;52838.73580632072;447798;450919;451084;452439;598539;27422.5886611697;27944.30139246535;28216.71783282223;28221;28266;42300.36549451699;43563.34654980114;43591.34612980745;43702.78148609237;44319.556804431544;34603;35284.117897052776;36597.26805463929;37195.44206836846;38162.618373817015;32676.34647306993;36026.91919242427;36789;37530.24939501249;38133.665321713604;37766.811165944;38162.42756358712;38497.84506464811;38652.80673596614;38796.8360949172;27367.45265094647;31558.36883262276;32628.510572340958;33488.8278910237;33694.49458258079;24724.505509890063;25043.87478062598;25089;25458.872705636353;25593.616095758953 15:45:50 INFO - PROCESS | 1671 | |2;jquery.html;363.2915814162382;417.599104859335;419.1261220355559;419.36256889527937;421.7090207756648;19691.803081969178;20913.686294705574;21357.038933248;21610.459738506546;21743.99999999998;20531.589368212626;20969;21830.672539911913;21838.23566175184;21853.344399668036;4788.736619485927;5795.101759227316;5977.6114552553945;5977.701114944257;5984.5511586630955;4966.329545511364;5909.556783241253;5959.10613407988;5964.1650168976375;6001.279846418436;5836.328822185439;5872.765089396419;5890.352061273278;5926.674032928208;5930.940690593082;5810.506106980891;5910.8473847599735;5933.22868027158;6036.939630603725;6050.062240352752;5285.682859028432;5676.631018983794;5967.075103358986;5983.880322393527;5987.0121429964;13641.386137623831;13711.794323085162;13798.93100534501;13868.4452621895;13879.95900307471;2196.934091977243;2285.3829466044076;2320.1995311617466;2671.1764880922715;2843.890882555805;8827.337949653738;10227.693169204937;10518.105960993325;13116.934415327862;13981.580552583438;1751.623400968785;1798.523391301293;1828.3692126216433;1840.098351807618;1878.7557617509774;101578;119037.40481297625;126898;129912.70087299195;134174.3291283547;9881.160101391319;11091.61354830646;11385.08919286455;11541.538338466535;11561.248518846416;13345.933270333586;14298.857011429753;15083.47207847742;15236.923815381075;15275.785011173317;8723.345749068845;8948.015718270985;9068.773280667903;9081.364304498753;9091.045440228812;7545.811354716176;9079.228265597498;9113.635454581876;9125.726228213165;9189.862152067724;4587.119281094735;4662.790174442158;4679.742614156254;4693.906121877543;4697.224957881979;1715.7683712698877;1899.6797225928124;1975.575251320973;2042.479167812228;2086.631673051098;867.8090820019586;869.7999460124207;1053.4732633683159;1073.409624706424;1074.2963358999868;19836.60326793456;20328.88191149501;20456;20462.386128416172;20600.175992960412;1009.2027298434301;1019.3068713275044;1027.1320733979776;1036.1969473657825;1060.2578195263347;10465.162786977024;10844.945775271073;10897.237193396386;10898.727531811768;11112.777744445228;618121;642731;648463;649562;657683;127175;128445.35777321241;132129;134827.65172348346;138278;956.5743244256239;1056.535124545213;1062.7502536903821;1104.812181929074;1128.4019469681082;14181.858181418054;16987.660246795243;17782.822171778116;17849.464516064538;17897.552561185552;51361.74319128381;52078.479215207364;52135.739321303154;53258.93482130413;55194.89610207693;67118.66440667765;71789.28210718035;72445.27554724597;78142.6092869532;78390.21609784057;8161.143079976754;8187.877181842158;8204.138565450541;8327.167283271867;8573.957130214309;11789.469473873525;12118.272903625459;12574.811377829523;12831.358432078172;12953.158044727063;10878.94560527224;11198.21612487118;11402.429878505876;11538.192326537062;11553.595624153451;11245.98786109254;11323.886761132284;11532.423378831192;11592.95663390299;11774.646760597196;11456.255343402652;11599.362035088152;11602.70993225176;11720.70698232551;12043.217190882564;8388.119247478928;8432.198941100585;8588.785280368042;8592.441491303045;8597;8632.136786321318;10964.671059868217;11368.488418021374;11460.312381257152;11726.237794543327 15:45:50 INFO - PROCESS | 1671 | |3;mootools.html;1408.8379836318827;1571.5678188498164;1578.8342224066473;1886.8490520758342;2060.1347434077684;8286.419950603453;8904.020557738644;9077.137671921173;9110.681126160585;9111.95212550556;8615.741527754162;8894.24398926092;8896.733098007055;8897;8937.329700272474;2561.871906404682;2588.7540683635025;2591.7796987256106;2592.779613732835;2593.935151621215;2505.8496490210555;2568.614707793827;2576.4331846993723;2578.046122934517;2585.9741402585923;2483.1433155561303;2509.560826855293;2520.8487490750613;2526.1411120219122;2526.873656317186;2527.229195095486;2566.2044766122467;2567.8844451999703;2577.497388009339;2579.1359894435386;2526.5924351552753;2553.6935567731807;2559.6032614944716;2566.987165064181;2602.518534071203;8859.468431894107;8918.152775486384;8950.955245223797;9005.549722513913;9102.998670146279;5760.452756988079;5932.851678708023;5998.8500287492725;6001.579889407743;6021.126936594169;3695.926081478355;3756.098536351283;3811.1805961718364;3818.866339678098;3824.6366595173413;1054.99472502637;1062.1131355318241;1069.443889177631;1081.0594982007315;1109.517359948417;12330.383480825923;12394.132410731252;12509.56216532417;12513.311767852765;12525.56160534377;4822.927656085091;4870.732109733999;4874.439439464436;4897.338859253955;4950.777215025332;9762.707118786448;9765.560549775277;9792.510374481248;9798.706038818847;9817.361871478332;5561.193626924154;5566.4990150886615;5574.052411090043;5576.079946808813;5592.5246354059545;4350.564943505624;4589.655775816827;5067.493250674903;5169.81905633301;5174.741262936838;3584.462330650423;3955;4049.392591111357;4086.9795651021554;4194.119234960632;1273.1024627637494;1278.8145718870899;1285.807128930668;1286.6976260578756;1295.352323838081;927.1377618814568;953.3374304858057;973.3186769261404;983.9065288797552;996.0637001218976;5354.437784032699;5999.160117583542;6003.609765365237;6134.78528251509;6163.506919446433;475.69793181330107;483.49233305029577;484.295350265363;487.03809975298503;502.40966863934733;3906.00396898789;3970.622790834866;4054.1486287879284;4081.673466122703;4143.047099167208;10844.620438284779;11170.329780213213;11226.607068752555;11413.828792568118;11459;11228.606998755004;11240.213185076966;11240.269382490113;11241.83137252942;11265.71835704114;8115.959420202861;8723.389362744674;8747.431416957877;8817;8840.160184782435;5908.231929849264;5958.612690175125;6072.969635151972;6114.327423983269;6154.538409619386;7903.68385264583;9480.668176613786;9540.570674319533;9657.951710241405;9753.512324383895;9989.750256243651;10036.899631003596;10112.64605738825;10137.493125343852;10346.430946298025;7080.398166155935;7273.163586187445;7505.849883002418;7887.44787864844;8054.033515977886;8408.495490270603;8497.065322814362;8507.319414446953;8542.18849209324;8561.058283588925;7361.227071157451;7485.812854678459;7525.435592330487;7553.962230188814;7568.621568921642;7325.450591205575;7370.5946172961;7409.184989651242;7465.850682986201;7546.24537546241;7018.192907815463;7118.928810711826;7156.9642151790995;7176.605286709281;7218.169910460364;4872.658913875995;5001.524855138756;5026.246063090565;5053.115704751727;5066.9746651266505;4988.850334489971;5061;5121.283020377075;5190.247414125006;5354.625176237626 15:45:50 INFO - PROCESS | 1671 | |4;prototype.html;330.75689368314283;332.37347599774426;341.6651681352274;345.94983727359516;346.56852218987365;6717.865642687143;6807.08104405905;6810.795676129724;6849.828754281146;6912.893936970086;6743.629100399476;6889.001094841245;6890.104286442768;6917.550359226647;6930.549514281581;5123.231515272721;5124.538791508763;5141.383034035912;5142.305788718512;5164.302819119427;4871.2206047032305;4981.576565991895;5147.794088236466;5159.793608255665;5180.792768289264;5061.3420255366755;5077.5684066854365;5084.542391184793;5102.821401250939;5112.948870511284;5080.974595127001;5092.567131793802;5101.2093125565225;5106.770195341219;5110.259012443212;4368.060866913629;4370.497392799837;4374;4374.781260936972;4390.912181756347;6602.141721576212;6618.867622647568;6621.966890165567;6626.635535045571;6639.402453779135;5802.274715660543;6000.729967151488;6022;6023.759049638009;6030.758769649253;7247.601381923992;7283.016792733019;7291.08861392326;7296.306850849161;7321.633918304064;4851.781669824831;4869.586085182764;4873.342098816685;4880.877978050542;4884.926726099111;7730.497517661334;7734.3039126478325;7738.7678369649;7739.071311442663;7755.302022817917;4583.381243532147;4958.652894297365;4964.404271487445;4970.353853998957;4974.850754477371;4578.404807375086;4853.684510506806;5048.798048078036;5088;5100.872478188075;5932.288125424977;6002.189704389939;6008.849778755479;6014.8195554133445;6017.0974353846395;7016.368526832507;7376.520526165782;7387.889181662279;7392.519486233377;7400.629968501554;1444.530527578541;1706.4624643237341;1708.7693161423297;1750.1861634340094;1753.4388995521565;1107.1640911112058;1110.9277896936674;1128.599347231721;1130.796456637813;1135.4549816088158;6775.593464392152;6776.593404395752;6788.93211067883;6805.455563554904;6806.659667016728;6029;7510.887336689954;7515.887261691079;7525.8118547035665;7526.548407095592;6157.9384206158265;6802.455803535705;6818.693158807866;6826.726930922807;6830.7609233676585;3169.2869104451775;3866.2654095722287;4002.4396584478195;4012.117334186474;4013;5873.122170136602;7659.8127290270095;7766.689332426753;7779.961100194463;7824.144187371682;6370.394812492806;7694.230576942261;7694.807629809187;7707.961460192663;7713.035870516185;7764.340031097307;7765.689372425153;7771.028621422322;7779.144294127642;7786.182450842806;5894.646321220741;6004.279486461653;6379.712912918837;7119.902842263632;7503.399728021636;6007.669578173242;6126.264848218242;7550.848983020419;7594.31651151399;7610.733624323122;6523.836904077436;7517;8021.598920054091;8034.87947680797;8038.356931445587;4804.0872234275375;4854.660173787801;4860.878478037936;4868.805247790048;4869;6968.79093627192;7279.927200728137;7654.425918056057;7658.195889431752;7661.540307581563;7290.380317673057;7298.978143060082;7305.196428392766;7329.1937886833475;7335.413166946738;7299.05112335393;7342;7379.704811807467;7382.926170738224;7390.334869861738;6410.967945160431;6751.493637977073;7226.855462890608;7234.348908598251;7250.746223882139;7032.929670703227;7240.674169662483;7396.038514993016;7405.111386633638;7422.14645315774;7063.858722825412;7116.608586527584;7124.073870397023;7128.750493732695;7142.107236595426 15:45:50 INFO - PROCESS | 1671 | |5;yui.html;699.2552931128349;767.3170877918657;784.3646646216562;787.5510958753509;788.6924099601157;12831.230126192411;14131.717365652694;14663.340149693262;15331.310091045902;15692.21538923055;14338.713225735479;14379.856201437982;14384.856151438482;14397.712045759079;14437.63905902353;758.2038859197834;778.8481246157002;951.7430293820664;978.4129522286643;978.7259567321125;943.4763706143087;952.980940381192;957.3490026781785;958.3435346787472;958.9136977672008;812.155358427235;1021.3412349034868;1033.5245786938017;1033.9276250662456;1035.0219043004363;840.0549381945311;1003.7289931718432;1009.7122320138799;1009.8636684047633;1010.0707349238718;763.5914785589738;763.9579823109726;765.3915137465729;765.4029856711774;765.6286700950035;15145.015573987766;15211.31549080283;15214.695706085817;15224.162671053087;15240.771388429182;12944.805827912589;12992.740145197138;13214.33928303581;13462.730745385037;13631.454741810316;11111.83332250017;11144.721381965435;11280.435978201058;11514.366709830956;11953;3602.225521512861;3620.094976255936;3639.1993761372455;3733.197362567061;3888.7083468739675;66636.6668166661;84564.7315290265;84846;86820.5658971701;87763.56118219432;8334.20825021622;10018.198544116452;10154.086132248132;10311.948440257751;10723.571057157782;23415.882920585627;23425;23431.882840585688;23459.7654023461;23547.646785298235;7653.425993050543;7689.846203075907;7739.3034626883855;7740.961295193488;7996.760097197093;3927.3127202739406;4195.328747400462;4260.905890075796;4344.9348259776125;4523.864284071483;3774.471573979645;3835.6547910688173;3835.7506762060375;3836.0985168485386;3837.6162383761957;624.4785604020602;676.8950812624051;701.579052568465;731.5537522111508;750.3884334267555;599.229989463546;608.3733754233147;608.5800797449746;637.5250438423404;645.1484041065842;8214.424990250745;8299.128591497927;8358.122397148212;8431.367647426345;8487.575621218914;542.5903442900664;575.9395263497272;597.333972620525;597.9073243647242;614.1954040207343;3512.631173726773;3869.090763670535;3911.9608803912165;4038.6567141793275;4086.162336720965;88524.5573772127;92345.61481577782;92758;92762;92813.53593232126;76649;77265.61367193128;77708.22291777123;78351.60824195843;78780.6060969703;69744.95382569266;70249;70401.64799176074;70776.58446831137;71080.64459677669;7948.244916732901;8105.351571874118;8139.633716482891;8157.836843262983;8229.382796290183;50477.99044019025;50542.49457505525;50844.74577627088;52380.47619523756;52515.47484525106;65767;68219;68652;69176;69805.65097174482;10532.52603632823;11086.889131108908;11124.61063862761;11383.089352851917;12089;11894.702632434259;12073.39633018328;12094.334811585448;12435;12476.812847807108;11525.135614828754;11759.294442333487;11792.412903739925;11873.52505899789;12110.697232569257;11878.287302761863;11888.04895608332;12102.818457723317;12128.332941688292;12135.92954738059;11728.530858765895;11768.94115529417;11861.940690296493;12158.270503769449;12597.559085431965;9534.856977145488;9665;10046;10063.39619622825;10246.590136394461;9741.172000380047;9995.800083998134;10010.8498372523;10040.347377420445;10085.259699655493 15:45:50 INFO - PROCESS | 1671 | __end_tp_report 15:45:50 INFO - PROCESS | 1671 | __start_cc_report 15:45:50 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1098 15:45:50 INFO - PROCESS | 1671 | __end_cc_report 15:45:50 INFO - PROCESS | 1671 | __startTimestamp1469141150889__endTimestamp 15:45:50 INFO - PROCESS | 1671 | 15:45:50 INFO - PROCESS | 1671 | ------- Summary: start ------- 15:45:50 INFO - PROCESS | 1671 | Number of tests: 6 15:45:50 INFO - PROCESS | 1671 | 15:45:50 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5918.76 Median:6196.63 stddev:633.34 (10.2%) stddev-sans-first:590.59 15:45:50 INFO - PROCESS | 1671 | Values: 2939.5 3574.4 3610.9 3657.4 3666.3 5906.2 5934.5 5952.3 5972.9 5984.4 5962.3 6009.9 6012.5 6014.2 6026.3 5295.3 5343.2 5412.0 5416.8 5454.1 5406.6 5450.3 5457.8 5458.0 5462.4 5366.5 5403.4 5408.6 5418.8 5433.4 5372.3 5402.5 5434.7 5441.9 5489.7 5214.1 5280.3 5352.1 5354.8 5373.8 5784.0 5796.2 5854.2 5863.2 5913.8 6261.7 6280.7 6287.8 6299.9 6304.9 6203.3 6289.2 6339.1 6360.9 6378.1 6031.0 6061.4 6082.2 6088.8 6108.5 6426.0 6429.6 6431.2 6433.6 6443.0 6196.6 6309.1 6314.7 6327.9 6345.5 6188.2 6288.9 6333.2 6341.3 6360.1 6319.7 6343.5 6346.4 6356.0 6377.7 6262.9 6282.6 6298.1 6318.2 6325.0 4989.3 5038.1 5048.1 5048.8 5050.2 4528.0 4567.7 4583.8 4610.3 4622.1 5955.5 6016.4 6032.1 6043.5 6043.8 6349.4 6355.6 6358.6 6358.9 6370.4 5850.7 5932.1 5953.6 5995.7 6014.8 5546.8 5576.6 5604.2 5632.9 5636.5 6469.9 6485.9 6503.9 6506.7 6527.2 6336.0 6346.8 6356.0 6357.9 6358.9 6370.4 6471.7 6491.3 6506.3 6509.5 6284.0 6291.9 6296.6 6305.6 6314.3 6184.7 6302.3 6308.7 6314.7 6326.7 6185.2 6189.8 6326.5 6327.5 6333.3 6250.2 6271.4 6286.9 6294.9 6312.0 6072.9 6090.8 6225.4 6230.8 6244.1 6206.7 6309.1 6314.3 6315.9 6320.2 6182.6 6217.4 6238.0 6242.2 6249.5 15:45:50 INFO - PROCESS | 1671 | 15:45:50 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:62307.04 Median:3486.87 stddev:136476.46 (3914.0%) stddev-sans-first:136780.52 15:45:50 INFO - PROCESS | 1671 | Values: 540.0 560.6 570.6 587.0 640.0 28694.3 39004.0 40037.8 40053.8 40128.4 38611.8 42828.7 42952.0 43279.8 43318.1 8830.8 9562.9 9761.4 9791.9 9792.4 8971.0 9083.0 11755.9 11981.6 12002.2 11583.2 11659.2 11677.4 11693.2 11700.8 11645.9 11661.6 11738.4 11742.7 11750.4 11399.0 11512.7 11515.0 11517.5 11529.7 39253.0 41940.8 42068.4 42129.8 42164.8 3488.2 3568.3 3607.9 3971.2 3995.1 29098.9 29595.7 29792.4 30213.8 31117.8 2758.3 2782.8 2802.6 2864.7 2890.5 327498.0 331968.0 332068.0 332253.7 332397.0 36910.6 37395.6 37444.0 37471.6 67212.7 35967.0 36226.0 36330.5 36338.6 36401.9 16241.9 16380.5 16384.8 16385.7 16417.8 12708.8 13029.4 13948.9 14018.3 14088.4 8327.5 8400.4 8421.4 8454.9 8460.6 3440.3 3485.6 3496.7 3499.2 3508.4 853.3 996.9 1027.4 1093.2 1181.6 30841.5 30934.1 30981.4 31105.7 31634.0 1132.8 1138.7 1154.0 1216.9 1291.5 15420.5 15684.7 15795.5 15958.9 16058.2 652908.0 656836.0 662022.0 662733.0 663121.0 63334.4 64023.7 64125.7 64144.4 64187.0 1392.3 1496.0 1513.4 1515.6 1557.7 28633.9 30995.5 31014.8 31219.7 31636.1 52154.7 52397.0 52626.7 52736.0 52838.7 447798.0 450919.0 451084.0 452439.0 598539.0 27422.6 27944.3 28216.7 28221.0 28266.0 42300.4 43563.3 43591.3 43702.8 44319.6 34603.0 35284.1 36597.3 37195.4 38162.6 32676.3 36026.9 36789.0 37530.2 38133.7 37766.8 38162.4 38497.8 38652.8 38796.8 27367.5 31558.4 32628.5 33488.8 33694.5 24724.5 25043.9 25089.0 25458.9 25593.6 15:45:50 INFO - PROCESS | 1671 | 15:45:50 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:36152.05 Median:11500.16 stddev:107191.81 (932.1%) stddev-sans-first:107458.83 15:45:50 INFO - PROCESS | 1671 | Values: 363.3 417.6 419.1 419.4 421.7 19691.8 20913.7 21357.0 21610.5 21744.0 20531.6 20969.0 21830.7 21838.2 21853.3 4788.7 5795.1 5977.6 5977.7 5984.6 4966.3 5909.6 5959.1 5964.2 6001.3 5836.3 5872.8 5890.4 5926.7 5930.9 5810.5 5910.8 5933.2 6036.9 6050.1 5285.7 5676.6 5967.1 5983.9 5987.0 13641.4 13711.8 13798.9 13868.4 13880.0 2196.9 2285.4 2320.2 2671.2 2843.9 8827.3 10227.7 10518.1 13116.9 13981.6 1751.6 1798.5 1828.4 1840.1 1878.8 101578.0 119037.4 126898.0 129912.7 134174.3 9881.2 11091.6 11385.1 11541.5 11561.2 13345.9 14298.9 15083.5 15236.9 15275.8 8723.3 8948.0 9068.8 9081.4 9091.0 7545.8 9079.2 9113.6 9125.7 9189.9 4587.1 4662.8 4679.7 4693.9 4697.2 1715.8 1899.7 1975.6 2042.5 2086.6 867.8 869.8 1053.5 1073.4 1074.3 19836.6 20328.9 20456.0 20462.4 20600.2 1009.2 1019.3 1027.1 1036.2 1060.3 10465.2 10844.9 10897.2 10898.7 11112.8 618121.0 642731.0 648463.0 649562.0 657683.0 127175.0 128445.4 132129.0 134827.7 138278.0 956.6 1056.5 1062.8 1104.8 1128.4 14181.9 16987.7 17782.8 17849.5 17897.6 51361.7 52078.5 52135.7 53258.9 55194.9 67118.7 71789.3 72445.3 78142.6 78390.2 8161.1 8187.9 8204.1 8327.2 8574.0 11789.5 12118.3 12574.8 12831.4 12953.2 10878.9 11198.2 11402.4 11538.2 11553.6 11246.0 11323.9 11532.4 11593.0 11774.6 11456.3 11599.4 11602.7 11720.7 12043.2 8388.1 8432.2 8588.8 8592.4 8597.0 8632.1 10964.7 11368.5 11460.3 11726.2 15:45:50 INFO - PROCESS | 1671 | 15:45:50 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5862.92 Median:5057.06 stddev:3270.55 (64.7%) stddev-sans-first:3262.59 15:45:50 INFO - PROCESS | 1671 | Values: 1408.8 1571.6 1578.8 1886.8 2060.1 8286.4 8904.0 9077.1 9110.7 9112.0 8615.7 8894.2 8896.7 8897.0 8937.3 2561.9 2588.8 2591.8 2592.8 2593.9 2505.8 2568.6 2576.4 2578.0 2586.0 2483.1 2509.6 2520.8 2526.1 2526.9 2527.2 2566.2 2567.9 2577.5 2579.1 2526.6 2553.7 2559.6 2567.0 2602.5 8859.5 8918.2 8951.0 9005.5 9103.0 5760.5 5932.9 5998.9 6001.6 6021.1 3695.9 3756.1 3811.2 3818.9 3824.6 1055.0 1062.1 1069.4 1081.1 1109.5 12330.4 12394.1 12509.6 12513.3 12525.6 4822.9 4870.7 4874.4 4897.3 4950.8 9762.7 9765.6 9792.5 9798.7 9817.4 5561.2 5566.5 5574.1 5576.1 5592.5 4350.6 4589.7 5067.5 5169.8 5174.7 3584.5 3955.0 4049.4 4087.0 4194.1 1273.1 1278.8 1285.8 1286.7 1295.4 927.1 953.3 973.3 983.9 996.1 5354.4 5999.2 6003.6 6134.8 6163.5 475.7 483.5 484.3 487.0 502.4 3906.0 3970.6 4054.1 4081.7 4143.0 10844.6 11170.3 11226.6 11413.8 11459.0 11228.6 11240.2 11240.3 11241.8 11265.7 8116.0 8723.4 8747.4 8817.0 8840.2 5908.2 5958.6 6073.0 6114.3 6154.5 7903.7 9480.7 9540.6 9658.0 9753.5 9989.8 10036.9 10112.6 10137.5 10346.4 7080.4 7273.2 7505.8 7887.4 8054.0 8408.5 8497.1 8507.3 8542.2 8561.1 7361.2 7485.8 7525.4 7554.0 7568.6 7325.5 7370.6 7409.2 7465.9 7546.2 7018.2 7118.9 7157.0 7176.6 7218.2 4872.7 5001.5 5026.2 5053.1 5067.0 4988.9 5061.0 5121.3 5190.2 5354.6 15:45:50 INFO - PROCESS | 1671 | 15:45:50 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:5940.92 Median:6678.63 stddev:1864.99 (27.9%) stddev-sans-first:1822.06 15:45:50 INFO - PROCESS | 1671 | Values: 330.8 332.4 341.7 345.9 346.6 6717.9 6807.1 6810.8 6849.8 6912.9 6743.6 6889.0 6890.1 6917.6 6930.5 5123.2 5124.5 5141.4 5142.3 5164.3 4871.2 4981.6 5147.8 5159.8 5180.8 5061.3 5077.6 5084.5 5102.8 5112.9 5081.0 5092.6 5101.2 5106.8 5110.3 4368.1 4370.5 4374.0 4374.8 4390.9 6602.1 6618.9 6622.0 6626.6 6639.4 5802.3 6000.7 6022.0 6023.8 6030.8 7247.6 7283.0 7291.1 7296.3 7321.6 4851.8 4869.6 4873.3 4880.9 4884.9 7730.5 7734.3 7738.8 7739.1 7755.3 4583.4 4958.7 4964.4 4970.4 4974.9 4578.4 4853.7 5048.8 5088.0 5100.9 5932.3 6002.2 6008.8 6014.8 6017.1 7016.4 7376.5 7387.9 7392.5 7400.6 1444.5 1706.5 1708.8 1750.2 1753.4 1107.2 1110.9 1128.6 1130.8 1135.5 6775.6 6776.6 6788.9 6805.5 6806.7 6029.0 7510.9 7515.9 7525.8 7526.5 6157.9 6802.5 6818.7 6826.7 6830.8 3169.3 3866.3 4002.4 4012.1 4013.0 5873.1 7659.8 7766.7 7780.0 7824.1 6370.4 7694.2 7694.8 7708.0 7713.0 7764.3 7765.7 7771.0 7779.1 7786.2 5894.6 6004.3 6379.7 7119.9 7503.4 6007.7 6126.3 7550.8 7594.3 7610.7 6523.8 7517.0 8021.6 8034.9 8038.4 4804.1 4854.7 4860.9 4868.8 4869.0 6968.8 7279.9 7654.4 7658.2 7661.5 7290.4 7299.0 7305.2 7329.2 7335.4 7299.1 7342.0 7379.7 7382.9 7390.3 6411.0 6751.5 7226.9 7234.3 7250.7 7032.9 7240.7 7396.0 7405.1 7422.1 7063.9 7116.6 7124.1 7128.8 7142.1 15:45:50 INFO - PROCESS | 1671 | 15:45:50 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18619.47 Median:4302.92 stddev:25811.46 (599.9%) stddev-sans-first:25848.79 15:45:50 INFO - PROCESS | 1671 | Values: 699.3 767.3 784.4 787.6 788.7 12831.2 14131.7 14663.3 15331.3 15692.2 14338.7 14379.9 14384.9 14397.7 14437.6 758.2 778.8 951.7 978.4 978.7 943.5 953.0 957.3 958.3 958.9 812.2 1021.3 1033.5 1033.9 1035.0 840.1 1003.7 1009.7 1009.9 1010.1 763.6 764.0 765.4 765.4 765.6 15145.0 15211.3 15214.7 15224.2 15240.8 12944.8 12992.7 13214.3 13462.7 13631.5 11111.8 11144.7 11280.4 11514.4 11953.0 3602.2 3620.1 3639.2 3733.2 3888.7 66636.7 84564.7 84846.0 86820.6 87763.6 8334.2 10018.2 10154.1 10311.9 10723.6 23415.9 23425.0 23431.9 23459.8 23547.6 7653.4 7689.8 7739.3 7741.0 7996.8 3927.3 4195.3 4260.9 4344.9 4523.9 3774.5 3835.7 3835.8 3836.1 3837.6 624.5 676.9 701.6 731.6 750.4 599.2 608.4 608.6 637.5 645.1 8214.4 8299.1 8358.1 8431.4 8487.6 542.6 575.9 597.3 597.9 614.2 3512.6 3869.1 3912.0 4038.7 4086.2 88524.6 92345.6 92758.0 92762.0 92813.5 76649.0 77265.6 77708.2 78351.6 78780.6 69745.0 70249.0 70401.6 70776.6 71080.6 7948.2 8105.4 8139.6 8157.8 8229.4 50478.0 50542.5 50844.7 52380.5 52515.5 65767.0 68219.0 68652.0 69176.0 69805.7 10532.5 11086.9 11124.6 11383.1 12089.0 11894.7 12073.4 12094.3 12435.0 12476.8 11525.1 11759.3 11792.4 11873.5 12110.7 11878.3 11888.0 12102.8 12128.3 12135.9 11728.5 11768.9 11861.9 12158.3 12597.6 9534.9 9665.0 10046.0 10063.4 10246.6 9741.2 9995.8 10010.8 10040.3 10085.3 15:45:50 INFO - PROCESS | 1671 | -------- Summary: end -------- 15:45:50 INFO - PROCESS | 1671 | 15:45:51 INFO - TEST-INFO | 1671: exit 0 15:45:51 INFO - TEST-OK | dromaeo_css | took 1112962ms 15:45:51 INFO - TEST-START | kraken 15:45:51 INFO - operating with platform_type : mac_ 15:45:51 INFO - Initialising browser for kraken test... 15:45:51 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmps06bdD/profile http://localhost:49275/getInfo.html) 15:45:53 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 15:45:53 INFO - PROCESS | 1677 | colorDepth:24 15:45:53 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 15:45:53 INFO - PROCESS | 1677 | __metrics 15:45:53 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:45:53 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:45:54 INFO - TEST-INFO | 1677: exit 0 15:45:54 INFO - Browser initialized. 15:45:54 INFO - Running cycle 1/1 for kraken test... 15:45:54 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmps06bdD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:06 INFO - PROCESS | 1680 | RSS: Main: 160329728 15:46:06 INFO - PROCESS | 1680 | 15:46:08 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 15:46:09 INFO - PROCESS | 1680 | RSS: Main: 226181120 15:46:09 INFO - PROCESS | 1680 | 15:46:12 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 15:46:12 INFO - PROCESS | 1680 | RSS: Main: 241897472 15:46:12 INFO - PROCESS | 1680 | 15:46:16 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 15:46:16 INFO - PROCESS | 1680 | RSS: Main: 327495680 15:46:16 INFO - PROCESS | 1680 | 15:46:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 15:46:19 INFO - PROCESS | 1680 | RSS: Main: 231837696 15:46:19 INFO - PROCESS | 1680 | 15:46:21 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:46:21 INFO - PROCESS | 1680 | RSS: Main: 232046592 15:46:21 INFO - PROCESS | 1680 | 15:46:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 15:46:25 INFO - PROCESS | 1680 | RSS: Main: 267919360 15:46:25 INFO - PROCESS | 1680 | 15:46:28 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 15:46:28 INFO - PROCESS | 1680 | RSS: Main: 269959168 15:46:28 INFO - PROCESS | 1680 | 15:46:31 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 15:46:32 INFO - PROCESS | 1680 | RSS: Main: 270385152 15:46:32 INFO - PROCESS | 1680 | 15:46:34 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:46:34 INFO - PROCESS | 1680 | RSS: Main: 260763648 15:46:34 INFO - PROCESS | 1680 | 15:46:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:46:37 INFO - PROCESS | 1680 | RSS: Main: 267796480 15:46:37 INFO - PROCESS | 1680 | 15:46:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:46:39 INFO - PROCESS | 1680 | RSS: Main: 271327232 15:46:39 INFO - PROCESS | 1680 | 15:46:42 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:46:43 INFO - PROCESS | 1680 | RSS: Main: 278482944 15:46:43 INFO - PROCESS | 1680 | 15:46:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:46:46 INFO - PROCESS | 1680 | RSS: Main: 275361792 15:46:46 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 15:46:48 INFO - PROCESS | 1680 | RSS: Main: 336494592 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | __start_tp_report 15:46:48 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 15:46:48 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 15:46:48 INFO - PROCESS | 1680 | |i|pagename|runs| 15:46:48 INFO - PROCESS | 1680 | |0;ai-astar;113;112;116;117;165;167;114;111;113;134 15:46:48 INFO - PROCESS | 1680 | |1;audio-beat-detection;155;118;141;161;118;138;120;154;185;150 15:46:48 INFO - PROCESS | 1680 | |2;audio-dft;186;187;184;184;184;184;185;186;186;183 15:46:48 INFO - PROCESS | 1680 | |3;audio-fft;70;78;97;150;57;55;58;64;131;55 15:46:48 INFO - PROCESS | 1680 | |4;audio-oscillator;92;92;134;79;85;90;122;79;77;124 15:46:48 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;87;85;87;84;87;83;88;83;89;84 15:46:48 INFO - PROCESS | 1680 | |6;imaging-darkroom;92;92;93;93;93;100;94;93;93;93 15:46:48 INFO - PROCESS | 1680 | |7;imaging-desaturate;137;144;86;94;139;133;87;100;140;141 15:46:48 INFO - PROCESS | 1680 | |8;json-parse-financial;60;63;66;62;62;62;63;78;62;56 15:46:48 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;61;63;61;69;71;72;70;66;66;61 15:46:48 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;80;80;79;79;79;78;78;79;79;84 15:46:48 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;138;140;126;124;123;124;123;124;145;161 15:46:48 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;159;163;167;165;191;212;194;164;145;176 15:46:48 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;67;67;67;66;68;68;66;65;68;69 15:46:48 INFO - PROCESS | 1680 | __end_tp_report 15:46:48 INFO - PROCESS | 1680 | __start_cc_report 15:46:48 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1883 15:46:48 INFO - PROCESS | 1680 | __end_cc_report 15:46:48 INFO - PROCESS | 1680 | __startTimestamp1469141208569__endTimestamp 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | ------- Summary: start ------- 15:46:48 INFO - PROCESS | 1680 | Number of tests: 14 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:126.20 Median:116.50 stddev:21.98 (18.9%) stddev-sans-first:22.79 15:46:48 INFO - PROCESS | 1680 | Values: 113.0 112.0 116.0 117.0 165.0 167.0 114.0 111.0 113.0 134.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:152.00 stddev:21.60 (14.2%) stddev-sans-first:22.54 15:46:48 INFO - PROCESS | 1680 | Values: 155.0 118.0 141.0 161.0 118.0 138.0 120.0 154.0 185.0 150.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.50 stddev:1.29 (0.7%) stddev-sans-first:1.30 15:46:48 INFO - PROCESS | 1680 | Values: 186.0 187.0 184.0 184.0 184.0 184.0 185.0 186.0 186.0 183.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:81.50 Median:61.00 stddev:33.98 (55.7%) stddev-sans-first:35.78 15:46:48 INFO - PROCESS | 1680 | Values: 70.0 78.0 97.0 150.0 57.0 55.0 58.0 64.0 131.0 55.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:82.00 stddev:21.11 (25.7%) stddev-sans-first:22.30 15:46:48 INFO - PROCESS | 1680 | Values: 92.0 92.0 134.0 79.0 85.0 90.0 122.0 79.0 77.0 124.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:87.00 stddev:2.16 (2.5%) stddev-sans-first:2.24 15:46:48 INFO - PROCESS | 1680 | Values: 87.0 85.0 87.0 84.0 87.0 83.0 88.0 83.0 89.0 84.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:93.00 stddev:2.32 (2.5%) stddev-sans-first:2.39 15:46:48 INFO - PROCESS | 1680 | Values: 92.0 92.0 93.0 93.0 93.0 100.0 94.0 93.0 93.0 93.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:120.10 Median:142.50 stddev:24.85 (17.4%) stddev-sans-first:25.59 15:46:48 INFO - PROCESS | 1680 | Values: 137.0 144.0 86.0 94.0 139.0 133.0 87.0 100.0 140.0 141.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:62.50 stddev:5.72 (9.2%) stddev-sans-first:5.93 15:46:48 INFO - PROCESS | 1680 | Values: 60.0 63.0 66.0 62.0 62.0 62.0 63.0 78.0 62.0 56.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:67.50 stddev:4.35 (6.4%) stddev-sans-first:4.22 15:46:48 INFO - PROCESS | 1680 | Values: 61.0 63.0 61.0 69.0 71.0 72.0 70.0 66.0 66.0 61.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:1.72 (2.2%) stddev-sans-first:1.81 15:46:48 INFO - PROCESS | 1680 | Values: 80.0 80.0 79.0 79.0 79.0 78.0 78.0 79.0 79.0 84.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:132.00 stddev:12.88 (9.8%) stddev-sans-first:13.53 15:46:48 INFO - PROCESS | 1680 | Values: 138.0 140.0 126.0 124.0 123.0 124.0 123.0 124.0 145.0 161.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:171.50 stddev:19.87 (11.6%) stddev-sans-first:20.36 15:46:48 INFO - PROCESS | 1680 | Values: 159.0 163.0 167.0 165.0 191.0 212.0 194.0 164.0 145.0 176.0 15:46:48 INFO - PROCESS | 1680 | 15:46:48 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.20 (1.8%) stddev-sans-first:1.27 15:46:48 INFO - PROCESS | 1680 | Values: 67.0 67.0 67.0 66.0 68.0 68.0 66.0 65.0 68.0 69.0 15:46:48 INFO - PROCESS | 1680 | -------- Summary: end -------- 15:46:48 INFO - PROCESS | 1680 | 15:46:49 INFO - TEST-INFO | 1680: exit 0 15:46:49 INFO - TEST-OK | kraken | took 58137ms 15:46:49 INFO - SUITE-END | took 1171s 15:46:49 INFO - Completed test suite (00:19:31) 15:46:49 INFO - javascript benchmark 15:46:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2939.470895238857, 3574.3566158091535, 3610.9097272568197, 3657.41481362982, 3666.3034023535524, 5906.232189815323, 5934.495567876736, 5952.255968003999, 5972.880542389161, 5984.371640977694, 5962.314333851608, 6009.909851352233, 6012.458878700927, 6014.188084608577, 6026.276846778382, 5295.28513650658, 5343.1985202219685, 5411.972940135293, 5416.83749487516, 5454.072807622713, 5406.648567843097, 5450.345958484968, 5457.808976685797, 5457.972710136463, 5462.371827239858, 5366.517013468807, 5403.405625381224, 5408.621396502246, 5418.756155972971, 5433.375161856397, 5372.328458942632, 5402.459754024605, 5434.728263586805, 5441.863953401157, 5489.6980666063355, 5214.113600687854, 5280.287161233223, 5352.143657014898, 5354.812581559627, 5373.811916582901, 5783.958887400267, 5796.159556864273, 5854.20968169296, 5863.208466856962, 5913.822585322448, 6261.7182226799905, 6280.654563998978, 6287.811365659038, 6299.905501417483, 6304.905426418607, 6203.286622038433, 6289.245290565115, 6339.1442155308905, 6360.936390636127, 6378.107065010902, 6030.96984515079, 6061.393860613947, 6082.239720034996, 6088.847778805565, 6108.539925731085, 6426.0, 6429.6142231466265, 6431.196100487439, 6433.613983161025, 6443.0, 6196.628202307876, 6309.14826498426, 6314.747410103544, 6327.905081423783, 6345.49236061114, 6188.195534580565, 6288.874222515616, 6333.240011198685, 6341.3341599132345, 6360.141380913517, 6319.747210111636, 6343.492520598341, 6346.397092276226, 6356.0, 6377.71300291488, 6262.937370626327, 6282.591631543935, 6298.118263443122, 6318.241810982711, 6324.988001919763, 4989.326440930428, 5038.0931432341795, 5048.0913435581215, 5048.848534543969, 5050.242463630485, 4527.9547204527535, 4567.748773817406, 4583.793729282191, 4610.308453731967, 4622.121796858653, 5955.493783028491, 6016.42843929826, 6032.125341825411, 6043.486303664238, 6043.7884674036195, 6349.428551430394, 6355.61866288015, 6358.586691865014, 6358.904616430665, 6370.362963703686, 5850.736716847752, 5932.110183472428, 5953.583249172516, 5995.730192141364, 6014.7594096236535, 5546.77812887488, 5576.637518561281, 5604.187392828098, 5632.859178520488, 5636.4927156556105, 6469.902951455732, 6485.870282594322, 6503.902441463382, 6506.674666266762, 6527.249366322933, 6336.049592561153, 6346.841328966812, 6355.968220159055, 6357.93642063592, 6358.936410635834, 6370.426661600478, 6471.741130354733, 6491.318411566906, 6506.284308725942, 6509.544331896722, 6284.0, 6291.874162516816, 6296.622202667854, 6305.5901366411035, 6314.273858506147, 6184.690765461619, 6302.275238347649, 6308.684565771601, 6314.6842657866, 6326.746930122744, 6185.165002724574, 6189.752409903554, 6326.525510586633, 6327.462165715966, 6333.334999824952, 6250.218722659668, 6271.404216599416, 6286.905696414466, 6294.937050629435, 6312.0, 6072.908906366496, 6090.786822461193, 6225.408586184305, 6230.813075607739, 6244.063390491463, 6206.689665516797, 6309.085182648399, 6314.336994615499, 6315.936840631535, 6320.241571011508, 6182.629042257479, 6217.440430361289, 6238.0, 6242.219722534684, 6249.531285153723], "value": 5878.585124855512, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.9730013499324, 560.6075746977116, 570.5891757934287, 586.9853253668658, 639.9552031357807, 28694.282642933937, 39004.0, 40037.79981100091, 40053.7997310013, 40128.39807402884, 38611.806940965325, 42828.71513854581, 42952.0, 43279.78360108195, 43318.133637327235, 8830.779230519223, 9562.904370956288, 9761.414315141079, 9791.853122203172, 9792.412455252672, 8971.013188549254, 9083.0, 11755.941220293887, 11981.580644677439, 12002.219855709394, 11583.247088939233, 11659.183857130005, 11677.357745324003, 11693.239939403955, 11700.765984680302, 11645.941770291136, 11661.591844285495, 11738.413079345999, 11742.706432339175, 11750.353730544817, 11399.0, 11512.654620361403, 11515.021223196038, 11517.48171332292, 11529.711757206052, 39253.01867453308, 41940.79029604863, 42068.37247902728, 42129.789351053354, 42164.78917605423, 3488.1628409181867, 3568.2863427314383, 3607.8917632471066, 3971.245463361952, 3995.081131339779, 29098.854505727548, 29595.70404295951, 29792.404151917057, 30213.848930755204, 31117.844410778027, 2758.2828464599347, 2782.8469434181316, 2802.565602331642, 2864.7135286471394, 2890.4941635213963, 327498.0, 331968.0, 332068.0, 332253.6774632247, 332397.0, 36910.630893691254, 37395.62604373921, 37444.0, 37471.62528374736, 67212.66393668098, 35967.0, 36226.0, 36330.45504317437, 36338.63661363405, 36401.90794276176, 16241.944273622177, 16380.508584742476, 16384.83615163833, 16385.672286554203, 16417.753733694004, 12708.809367859489, 13029.413676384396, 13948.86051139496, 14018.299085045706, 14088.43646254159, 8327.541985190752, 8400.41197116196, 8421.368397370221, 8454.87317690235, 8460.561704510248, 3440.2775417162175, 3485.5817301923425, 3496.650334966534, 3499.16020155166, 3508.3509550733197, 853.3343991686495, 996.875390576178, 1027.3733022856052, 1093.1691914145306, 1181.5687274145048, 30841.537376939363, 30934.090954087605, 30981.380372392425, 31105.68894311073, 31634.0, 1132.774098895674, 1138.7210133517342, 1153.9826902596467, 1216.9148159628742, 1291.5479582146174, 15420.460283890234, 15684.68630627381, 15795.526134215992, 15958.92020539913, 16058.197090145446, 652908.0, 656836.0, 662022.0, 662733.0, 663121.0, 63334.366656332844, 64023.67988160122, 64125.67937160284, 64144.35855641477, 64187.0, 1392.324722509582, 1496.0051565708682, 1513.3643869574805, 1515.5756388211319, 1557.7429724095398, 28633.856830715715, 30995.535066974466, 31014.844925775225, 31219.687803121677, 31636.050918472483, 52154.739226305144, 52397.0, 52626.73686631543, 52736.0, 52838.73580632072, 447798.0, 450919.0, 451084.0, 452439.0, 598539.0, 27422.5886611697, 27944.30139246535, 28216.71783282223, 28221.0, 28266.0, 42300.36549451699, 43563.34654980114, 43591.34612980745, 43702.78148609237, 44319.556804431544, 34603.0, 35284.117897052776, 36597.26805463929, 37195.44206836846, 38162.618373817015, 32676.34647306993, 36026.91919242427, 36789.0, 37530.24939501249, 38133.665321713604, 37766.811165944, 38162.42756358712, 38497.84506464811, 38652.80673596614, 38796.8360949172, 27367.45265094647, 31558.36883262276, 32628.510572340958, 33488.8278910237, 33694.49458258079, 24724.505509890063, 25043.87478062598, 25089.0, 25458.872705636353, 25593.616095758953], "value": 18930.667517405593, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.2915814162382, 417.599104859335, 419.1261220355559, 419.36256889527937, 421.7090207756648, 19691.803081969178, 20913.686294705574, 21357.038933248, 21610.459738506546, 21743.99999999998, 20531.589368212626, 20969.0, 21830.672539911913, 21838.23566175184, 21853.344399668036, 4788.736619485927, 5795.101759227316, 5977.6114552553945, 5977.701114944257, 5984.5511586630955, 4966.329545511364, 5909.556783241253, 5959.10613407988, 5964.1650168976375, 6001.279846418436, 5836.328822185439, 5872.765089396419, 5890.352061273278, 5926.674032928208, 5930.940690593082, 5810.506106980891, 5910.8473847599735, 5933.22868027158, 6036.939630603725, 6050.062240352752, 5285.682859028432, 5676.631018983794, 5967.075103358986, 5983.880322393527, 5987.0121429964, 13641.386137623831, 13711.794323085162, 13798.93100534501, 13868.4452621895, 13879.95900307471, 2196.934091977243, 2285.3829466044076, 2320.1995311617466, 2671.1764880922715, 2843.890882555805, 8827.337949653738, 10227.693169204937, 10518.105960993325, 13116.934415327862, 13981.580552583438, 1751.623400968785, 1798.523391301293, 1828.3692126216433, 1840.098351807618, 1878.7557617509774, 101578.0, 119037.40481297625, 126898.0, 129912.70087299195, 134174.3291283547, 9881.160101391319, 11091.61354830646, 11385.08919286455, 11541.538338466535, 11561.248518846416, 13345.933270333586, 14298.857011429753, 15083.47207847742, 15236.923815381075, 15275.785011173317, 8723.345749068845, 8948.015718270985, 9068.773280667903, 9081.364304498753, 9091.045440228812, 7545.811354716176, 9079.228265597498, 9113.635454581876, 9125.726228213165, 9189.862152067724, 4587.119281094735, 4662.790174442158, 4679.742614156254, 4693.906121877543, 4697.224957881979, 1715.7683712698877, 1899.6797225928124, 1975.575251320973, 2042.479167812228, 2086.631673051098, 867.8090820019586, 869.7999460124207, 1053.4732633683159, 1073.409624706424, 1074.2963358999868, 19836.60326793456, 20328.88191149501, 20456.0, 20462.386128416172, 20600.175992960412, 1009.2027298434301, 1019.3068713275044, 1027.1320733979776, 1036.1969473657825, 1060.2578195263347, 10465.162786977024, 10844.945775271073, 10897.237193396386, 10898.727531811768, 11112.777744445228, 618121.0, 642731.0, 648463.0, 649562.0, 657683.0, 127175.0, 128445.35777321241, 132129.0, 134827.65172348346, 138278.0, 956.5743244256239, 1056.535124545213, 1062.7502536903821, 1104.812181929074, 1128.4019469681082, 14181.858181418054, 16987.660246795243, 17782.822171778116, 17849.464516064538, 17897.552561185552, 51361.74319128381, 52078.479215207364, 52135.739321303154, 53258.93482130413, 55194.89610207693, 67118.66440667765, 71789.28210718035, 72445.27554724597, 78142.6092869532, 78390.21609784057, 8161.143079976754, 8187.877181842158, 8204.138565450541, 8327.167283271867, 8573.957130214309, 11789.469473873525, 12118.272903625459, 12574.811377829523, 12831.358432078172, 12953.158044727063, 10878.94560527224, 11198.21612487118, 11402.429878505876, 11538.192326537062, 11553.595624153451, 11245.98786109254, 11323.886761132284, 11532.423378831192, 11592.95663390299, 11774.646760597196, 11456.255343402652, 11599.362035088152, 11602.70993225176, 11720.70698232551, 12043.217190882564, 8388.119247478928, 8432.198941100585, 8588.785280368042, 8592.441491303045, 8597.0, 8632.136786321318, 10964.671059868217, 11368.488418021374, 11460.312381257152, 11726.237794543327], "value": 9608.556796540013, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.8379836318827, 1571.5678188498164, 1578.8342224066473, 1886.8490520758342, 2060.1347434077684, 8286.419950603453, 8904.020557738644, 9077.137671921173, 9110.681126160585, 9111.95212550556, 8615.741527754162, 8894.24398926092, 8896.733098007055, 8897.0, 8937.329700272474, 2561.871906404682, 2588.7540683635025, 2591.7796987256106, 2592.779613732835, 2593.935151621215, 2505.8496490210555, 2568.614707793827, 2576.4331846993723, 2578.046122934517, 2585.9741402585923, 2483.1433155561303, 2509.560826855293, 2520.8487490750613, 2526.1411120219122, 2526.873656317186, 2527.229195095486, 2566.2044766122467, 2567.8844451999703, 2577.497388009339, 2579.1359894435386, 2526.5924351552753, 2553.6935567731807, 2559.6032614944716, 2566.987165064181, 2602.518534071203, 8859.468431894107, 8918.152775486384, 8950.955245223797, 9005.549722513913, 9102.998670146279, 5760.452756988079, 5932.851678708023, 5998.8500287492725, 6001.579889407743, 6021.126936594169, 3695.926081478355, 3756.098536351283, 3811.1805961718364, 3818.866339678098, 3824.6366595173413, 1054.99472502637, 1062.1131355318241, 1069.443889177631, 1081.0594982007315, 1109.517359948417, 12330.383480825923, 12394.132410731252, 12509.56216532417, 12513.311767852765, 12525.56160534377, 4822.927656085091, 4870.732109733999, 4874.439439464436, 4897.338859253955, 4950.777215025332, 9762.707118786448, 9765.560549775277, 9792.510374481248, 9798.706038818847, 9817.361871478332, 5561.193626924154, 5566.4990150886615, 5574.052411090043, 5576.079946808813, 5592.5246354059545, 4350.564943505624, 4589.655775816827, 5067.493250674903, 5169.81905633301, 5174.741262936838, 3584.462330650423, 3955.0, 4049.392591111357, 4086.9795651021554, 4194.119234960632, 1273.1024627637494, 1278.8145718870899, 1285.807128930668, 1286.6976260578756, 1295.352323838081, 927.1377618814568, 953.3374304858057, 973.3186769261404, 983.9065288797552, 996.0637001218976, 5354.437784032699, 5999.160117583542, 6003.609765365237, 6134.78528251509, 6163.506919446433, 475.69793181330107, 483.49233305029577, 484.295350265363, 487.03809975298503, 502.40966863934733, 3906.00396898789, 3970.622790834866, 4054.1486287879284, 4081.673466122703, 4143.047099167208, 10844.620438284779, 11170.329780213213, 11226.607068752555, 11413.828792568118, 11459.0, 11228.606998755004, 11240.213185076966, 11240.269382490113, 11241.83137252942, 11265.71835704114, 8115.959420202861, 8723.389362744674, 8747.431416957877, 8817.0, 8840.160184782435, 5908.231929849264, 5958.612690175125, 6072.969635151972, 6114.327423983269, 6154.538409619386, 7903.68385264583, 9480.668176613786, 9540.570674319533, 9657.951710241405, 9753.512324383895, 9989.750256243651, 10036.899631003596, 10112.64605738825, 10137.493125343852, 10346.430946298025, 7080.398166155935, 7273.163586187445, 7505.849883002418, 7887.44787864844, 8054.033515977886, 8408.495490270603, 8497.065322814362, 8507.319414446953, 8542.18849209324, 8561.058283588925, 7361.227071157451, 7485.812854678459, 7525.435592330487, 7553.962230188814, 7568.621568921642, 7325.450591205575, 7370.5946172961, 7409.184989651242, 7465.850682986201, 7546.24537546241, 7018.192907815463, 7118.928810711826, 7156.9642151790995, 7176.605286709281, 7218.169910460364, 4872.658913875995, 5001.524855138756, 5026.246063090565, 5053.115704751727, 5066.9746651266505, 4988.850334489971, 5061.0, 5121.283020377075, 5190.247414125006, 5354.625176237626], "value": 4665.372692021787, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.75689368314283, 332.37347599774426, 341.6651681352274, 345.94983727359516, 346.56852218987365, 6717.865642687143, 6807.08104405905, 6810.795676129724, 6849.828754281146, 6912.893936970086, 6743.629100399476, 6889.001094841245, 6890.104286442768, 6917.550359226647, 6930.549514281581, 5123.231515272721, 5124.538791508763, 5141.383034035912, 5142.305788718512, 5164.302819119427, 4871.2206047032305, 4981.576565991895, 5147.794088236466, 5159.793608255665, 5180.792768289264, 5061.3420255366755, 5077.5684066854365, 5084.542391184793, 5102.821401250939, 5112.948870511284, 5080.974595127001, 5092.567131793802, 5101.2093125565225, 5106.770195341219, 5110.259012443212, 4368.060866913629, 4370.497392799837, 4374.0, 4374.781260936972, 4390.912181756347, 6602.141721576212, 6618.867622647568, 6621.966890165567, 6626.635535045571, 6639.402453779135, 5802.274715660543, 6000.729967151488, 6022.0, 6023.759049638009, 6030.758769649253, 7247.601381923992, 7283.016792733019, 7291.08861392326, 7296.306850849161, 7321.633918304064, 4851.781669824831, 4869.586085182764, 4873.342098816685, 4880.877978050542, 4884.926726099111, 7730.497517661334, 7734.3039126478325, 7738.7678369649, 7739.071311442663, 7755.302022817917, 4583.381243532147, 4958.652894297365, 4964.404271487445, 4970.353853998957, 4974.850754477371, 4578.404807375086, 4853.684510506806, 5048.798048078036, 5088.0, 5100.872478188075, 5932.288125424977, 6002.189704389939, 6008.849778755479, 6014.8195554133445, 6017.0974353846395, 7016.368526832507, 7376.520526165782, 7387.889181662279, 7392.519486233377, 7400.629968501554, 1444.530527578541, 1706.4624643237341, 1708.7693161423297, 1750.1861634340094, 1753.4388995521565, 1107.1640911112058, 1110.9277896936674, 1128.599347231721, 1130.796456637813, 1135.4549816088158, 6775.593464392152, 6776.593404395752, 6788.93211067883, 6805.455563554904, 6806.659667016728, 6029.0, 7510.887336689954, 7515.887261691079, 7525.8118547035665, 7526.548407095592, 6157.9384206158265, 6802.455803535705, 6818.693158807866, 6826.726930922807, 6830.7609233676585, 3169.2869104451775, 3866.2654095722287, 4002.4396584478195, 4012.117334186474, 4013.0, 5873.122170136602, 7659.8127290270095, 7766.689332426753, 7779.961100194463, 7824.144187371682, 6370.394812492806, 7694.230576942261, 7694.807629809187, 7707.961460192663, 7713.035870516185, 7764.340031097307, 7765.689372425153, 7771.028621422322, 7779.144294127642, 7786.182450842806, 5894.646321220741, 6004.279486461653, 6379.712912918837, 7119.902842263632, 7503.399728021636, 6007.669578173242, 6126.264848218242, 7550.848983020419, 7594.31651151399, 7610.733624323122, 6523.836904077436, 7517.0, 8021.598920054091, 8034.87947680797, 8038.356931445587, 4804.0872234275375, 4854.660173787801, 4860.878478037936, 4868.805247790048, 4869.0, 6968.79093627192, 7279.927200728137, 7654.425918056057, 7658.195889431752, 7661.540307581563, 7290.380317673057, 7298.978143060082, 7305.196428392766, 7329.1937886833475, 7335.413166946738, 7299.05112335393, 7342.0, 7379.704811807467, 7382.926170738224, 7390.334869861738, 6410.967945160431, 6751.493637977073, 7226.855462890608, 7234.348908598251, 7250.746223882139, 7032.929670703227, 7240.674169662483, 7396.038514993016, 7405.111386633638, 7422.14645315774, 7063.858722825412, 7116.608586527584, 7124.073870397023, 7128.750493732695, 7142.107236595426], "value": 5318.151871277943, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.2552931128349, 767.3170877918657, 784.3646646216562, 787.5510958753509, 788.6924099601157, 12831.230126192411, 14131.717365652694, 14663.340149693262, 15331.310091045902, 15692.21538923055, 14338.713225735479, 14379.856201437982, 14384.856151438482, 14397.712045759079, 14437.63905902353, 758.2038859197834, 778.8481246157002, 951.7430293820664, 978.4129522286643, 978.7259567321125, 943.4763706143087, 952.980940381192, 957.3490026781785, 958.3435346787472, 958.9136977672008, 812.155358427235, 1021.3412349034868, 1033.5245786938017, 1033.9276250662456, 1035.0219043004363, 840.0549381945311, 1003.7289931718432, 1009.7122320138799, 1009.8636684047633, 1010.0707349238718, 763.5914785589738, 763.9579823109726, 765.3915137465729, 765.4029856711774, 765.6286700950035, 15145.015573987766, 15211.31549080283, 15214.695706085817, 15224.162671053087, 15240.771388429182, 12944.805827912589, 12992.740145197138, 13214.33928303581, 13462.730745385037, 13631.454741810316, 11111.83332250017, 11144.721381965435, 11280.435978201058, 11514.366709830956, 11953.0, 3602.225521512861, 3620.094976255936, 3639.1993761372455, 3733.197362567061, 3888.7083468739675, 66636.6668166661, 84564.7315290265, 84846.0, 86820.5658971701, 87763.56118219432, 8334.20825021622, 10018.198544116452, 10154.086132248132, 10311.948440257751, 10723.571057157782, 23415.882920585627, 23425.0, 23431.882840585688, 23459.7654023461, 23547.646785298235, 7653.425993050543, 7689.846203075907, 7739.3034626883855, 7740.961295193488, 7996.760097197093, 3927.3127202739406, 4195.328747400462, 4260.905890075796, 4344.9348259776125, 4523.864284071483, 3774.471573979645, 3835.6547910688173, 3835.7506762060375, 3836.0985168485386, 3837.6162383761957, 624.4785604020602, 676.8950812624051, 701.579052568465, 731.5537522111508, 750.3884334267555, 599.229989463546, 608.3733754233147, 608.5800797449746, 637.5250438423404, 645.1484041065842, 8214.424990250745, 8299.128591497927, 8358.122397148212, 8431.367647426345, 8487.575621218914, 542.5903442900664, 575.9395263497272, 597.333972620525, 597.9073243647242, 614.1954040207343, 3512.631173726773, 3869.090763670535, 3911.9608803912165, 4038.6567141793275, 4086.162336720965, 88524.5573772127, 92345.61481577782, 92758.0, 92762.0, 92813.53593232126, 76649.0, 77265.61367193128, 77708.22291777123, 78351.60824195843, 78780.6060969703, 69744.95382569266, 70249.0, 70401.64799176074, 70776.58446831137, 71080.64459677669, 7948.244916732901, 8105.351571874118, 8139.633716482891, 8157.836843262983, 8229.382796290183, 50477.99044019025, 50542.49457505525, 50844.74577627088, 52380.47619523756, 52515.47484525106, 65767.0, 68219.0, 68652.0, 69176.0, 69805.65097174482, 10532.52603632823, 11086.889131108908, 11124.61063862761, 11383.089352851917, 12089.0, 11894.702632434259, 12073.39633018328, 12094.334811585448, 12435.0, 12476.812847807108, 11525.135614828754, 11759.294442333487, 11792.412903739925, 11873.52505899789, 12110.697232569257, 11878.287302761863, 11888.04895608332, 12102.818457723317, 12128.332941688292, 12135.92954738059, 11728.530858765895, 11768.94115529417, 11861.940690296493, 12158.270503769449, 12597.559085431965, 9534.856977145488, 9665.0, 10046.0, 10063.39619622825, 10246.590136394461, 9741.172000380047, 9995.800083998134, 10010.8498372523, 10040.347377420445, 10085.259699655493], "value": 7147.452398319186, "unit": "score"}], "name": "dromaeo_css", "value": 7579.7491371132055, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 116.0, 117.0, 165.0, 167.0, 114.0, 111.0, 113.0, 134.0], "value": 126.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 141.0, 161.0, 118.0, 138.0, 120.0, 154.0, 185.0, 150.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 184.0, 184.0, 184.0, 184.0, 185.0, 186.0, 186.0, 183.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 97.0, 150.0, 57.0, 55.0, 58.0, 64.0, 131.0, 55.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 134.0, 79.0, 85.0, 90.0, 122.0, 79.0, 77.0, 124.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 87.0, 83.0, 88.0, 83.0, 89.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 93.0, 93.0, 100.0, 94.0, 93.0, 93.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 144.0, 86.0, 94.0, 139.0, 133.0, 87.0, 100.0, 140.0, 141.0], "value": 120.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 66.0, 62.0, 62.0, 62.0, 63.0, 78.0, 62.0, 56.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 69.0, 71.0, 72.0, 70.0, 66.0, 66.0, 61.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 79.0, 78.0, 78.0, 79.0, 79.0, 84.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 126.0, 124.0, 123.0, 124.0, 123.0, 124.0, 145.0, 161.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 167.0, 165.0, 191.0, 212.0, 194.0, 164.0, 145.0, 176.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 68.0, 68.0, 66.0, 65.0, 68.0, 69.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1515.8, "alertThreshold": 2.0}]} 15:46:49 INFO - Return code: 0 15:46:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:46:49 ERROR - # TBPL SUCCESS # 15:46:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:46:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:46:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:46:49 INFO - 2016-07-21 15:46:49.893 screenresolution[1684:10429] starting screenresolution argv=screenresolution get 15:46:49 INFO - 2016-07-21 15:46:49.896 screenresolution[1684:10429] Display 0: 1600x1200x32@60 15:46:49 INFO - 2016-07-21 15:46:49.902 screenresolution[1685:10432] starting screenresolution argv=screenresolution list 15:46:49 INFO - Available Modes on Display 0 15:46:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:46:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:46:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:46:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:46:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:46:50 INFO - Intel Iris: 15:46:50 INFO - Chipset Model: Intel Iris 15:46:50 INFO - Type: GPU 15:46:50 INFO - Bus: Built-In 15:46:50 INFO - VRAM (Dynamic, Max): 1536 MB 15:46:50 INFO - Vendor: Intel (0x8086) 15:46:50 INFO - Device ID: 0x0a2e 15:46:50 INFO - Revision ID: 0x0009 15:46:50 INFO - Displays: 15:46:50 INFO - Display: 15:46:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:46:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:46:50 INFO - Display Serial Number: 1600x1200 60 15:46:50 INFO - Main Display: Yes 15:46:50 INFO - Mirror: Off 15:46:50 INFO - Online: Yes 15:46:50 INFO - Rotation: Supported 15:46:50 INFO - Return code: 0 15:46:50 INFO - Running post-action listener: _resource_record_post_action 15:46:50 INFO - Running post-run listener: _resource_record_post_run 15:46:51 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 31677952; Write bytes: 494737920; Read time: 197; Write time: 1554 15:46:51 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193442304; Write bytes: 186934784; Read time: 17528; Write time: 425 15:46:51 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 29896192; Write bytes: 298058752; Read time: 182; Write time: 1096 15:46:51 INFO - Running post-run listener: _upload_blobber_files 15:46:51 INFO - Blob upload gear active. 15:46:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:46:51 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 15:46:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:46:51 INFO - (blobuploader) - INFO - Open directory for files ... 15:46:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:46:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:46:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:52 INFO - (blobuploader) - INFO - Done attempting. 15:46:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:46:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:46:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:53 INFO - (blobuploader) - INFO - Done attempting. 15:46:53 INFO - (blobuploader) - INFO - Iteration through files over. 15:46:53 INFO - Return code: 0 15:46:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:46:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:46:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ed959dd284e0bbd22d9b8f5929c0d14457bfd9d16abe510663ba0571e9a08fe23e0292f2b40cf17a33f394fe2f2b58f9de81709e16d7620467f44e834e0b4d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a947ceca16ca8c84774add43b8705a4e4868a88446bc59e0beb37ed3d536588a7ad5742cc14b630fa2a61c6d4afaaac3a2d7ef98fc5d19ae14fa58783b845710"} 15:46:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:46:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:46:53 INFO - Contents: 15:46:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ed959dd284e0bbd22d9b8f5929c0d14457bfd9d16abe510663ba0571e9a08fe23e0292f2b40cf17a33f394fe2f2b58f9de81709e16d7620467f44e834e0b4d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a947ceca16ca8c84774add43b8705a4e4868a88446bc59e0beb37ed3d536588a7ad5742cc14b630fa2a61c6d4afaaac3a2d7ef98fc5d19ae14fa58783b845710"} 15:46:53 INFO - Running post-run listener: copy_logs_to_upload_dir 15:46:53 INFO - Copying logs to upload dir... 15:46:53 INFO - mkdir: /builds/slave/test/build/upload/logs 15:46:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.385064 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-21 15:46:54.016813) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 15:46:54.020407) ========= 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.3rndaFp50K/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.HuCHVXLcq7/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ed959dd284e0bbd22d9b8f5929c0d14457bfd9d16abe510663ba0571e9a08fe23e0292f2b40cf17a33f394fe2f2b58f9de81709e16d7620467f44e834e0b4d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a947ceca16ca8c84774add43b8705a4e4868a88446bc59e0beb37ed3d536588a7ad5742cc14b630fa2a61c6d4afaaac3a2d7ef98fc5d19ae14fa58783b845710"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011212 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469111878/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ed959dd284e0bbd22d9b8f5929c0d14457bfd9d16abe510663ba0571e9a08fe23e0292f2b40cf17a33f394fe2f2b58f9de81709e16d7620467f44e834e0b4d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a947ceca16ca8c84774add43b8705a4e4868a88446bc59e0beb37ed3d536588a7ad5742cc14b630fa2a61c6d4afaaac3a2d7ef98fc5d19ae14fa58783b845710"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 15:46:54.054129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:46:54.054500) ========= 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.3rndaFp50K/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.HuCHVXLcq7/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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.005001 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:46:54.106899) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 15:46:54.107707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 15:46:54.108424) ========= ========= Total master_lag: 0.23 =========