builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0345 starttime: 1468897919.22 results: success (0) buildid: 20160718082858 builduid: 45ab1cec1c9e4d789d92b52f048d1303 revision: 0f4257230dffa106e90cf736df9dbe9859ac5274 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:59.221825) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:59.222252) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:59.222539) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:59.246759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:59.247127) ========= 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.RTo9gmTu0O/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.0LQABS8mqy/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-18 20:11: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% 170M=0s 2016-07-18 20:11:59 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:59.356071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:59.356382) ========= 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.RTo9gmTu0O/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.0LQABS8mqy/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.025348 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:59.407495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 20:11:59.410871) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f4257230dffa106e90cf736df9dbe9859ac5274 --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 0f4257230dffa106e90cf736df9dbe9859ac5274 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RTo9gmTu0O/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.0LQABS8mqy/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-18 20:11:59,490 truncating revision to first 12 chars 2016-07-18 20:11:59,490 Setting DEBUG logging. 2016-07-18 20:11:59,490 attempt 1/10 2016-07-18 20:11:59,490 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0f4257230dff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 20:12:00,577 unpacking tar archive at: mozilla-beta-0f4257230dff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.335242 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 20:12:00.767742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:12:00.768177) ========= script_repo_revision: 0f4257230dffa106e90cf736df9dbe9859ac5274 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:12:00.768556) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:12:00.768836) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:12:00.786470) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-18 20:12:00.786739) ========= /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.RTo9gmTu0O/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.0LQABS8mqy/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 20:12:00 INFO - MultiFileLogger online at 20160718 20:12:00 in /builds/slave/test 20:12:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:12:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:12:00 INFO - {'append_to_log': False, 20:12:00 INFO - 'base_work_dir': '/builds/slave/test', 20:12:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:12:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:12:00 INFO - 'branch': 'Mozilla-Beta', 20:12:00 INFO - 'buildbot_json_path': 'buildprops.json', 20:12:00 INFO - 'config_files': ('talos/mac_config.py',), 20:12:00 INFO - 'default_actions': ('clobber', 20:12:00 INFO - 'read-buildbot-config', 20:12:00 INFO - 'download-and-extract', 20:12:00 INFO - 'populate-webroot', 20:12:00 INFO - 'create-virtualenv', 20:12:00 INFO - 'install', 20:12:00 INFO - 'run-tests'), 20:12:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:12:00 INFO - 'download_minidump_stackwalk': True, 20:12:00 INFO - 'download_symbols': 'ondemand', 20:12:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:12:00 INFO - 'tooltool.py': '/tools/tooltool.py', 20:12:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:12:00 INFO - '/tools/misc-python/virtualenv.py')}, 20:12:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:12:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:12:00 INFO - 'installer_path': 'installer.exe', 20:12:00 INFO - 'log_level': 'info', 20:12:00 INFO - 'log_name': 'talos', 20:12:00 INFO - 'log_to_console': True, 20:12:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:12:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:12:00 INFO - 'opt_config_files': (), 20:12:00 INFO - 'pip_index': False, 20:12:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:12:00 INFO - 'cmd': ('bash', 20:12:00 INFO - '-c', 20:12:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:12:00 INFO - 'enabled': True, 20:12:00 INFO - 'halt_on_failure': False, 20:12:00 INFO - 'name': 'check_screen_resolution'},), 20:12:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:12:00 INFO - 'cmd': ('bash', 20:12:00 INFO - '-c', 20:12:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:12:00 INFO - 'enabled': True, 20:12:00 INFO - 'halt_on_failure': False, 20:12:00 INFO - 'name': 'check_screen_resolution'},), 20:12:00 INFO - 'run_cmd_checks_enabled': True, 20:12:00 INFO - 'sps_profile': False, 20:12:00 INFO - 'sps_profile_interval': 0, 20:12:00 INFO - 'suite': 'dromaeojs', 20:12:00 INFO - 'system_bits': '32', 20:12:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:12:00 INFO - 'title': 't-yosemite-r7-0345', 20:12:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:12:00 INFO - 'use_talos_json': True, 20:12:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:12:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:12:00 INFO - 'work_dir': 'build'} 20:12:00 INFO - ##### 20:12:00 INFO - ##### Running clobber step. 20:12:00 INFO - ##### 20:12:00 INFO - Running pre-action listener: _resource_record_pre_action 20:12:00 INFO - Running main action method: clobber 20:12:00 INFO - rmtree: /builds/slave/test/build 20:12:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:12:03 INFO - Running post-action listener: _resource_record_post_action 20:12:03 INFO - ##### 20:12:03 INFO - ##### Running read-buildbot-config step. 20:12:03 INFO - ##### 20:12:03 INFO - Running pre-action listener: _resource_record_pre_action 20:12:03 INFO - Running main action method: read_buildbot_config 20:12:03 INFO - Using buildbot properties: 20:12:03 INFO - { 20:12:03 INFO - "project": "", 20:12:03 INFO - "product": "firefox", 20:12:03 INFO - "script_repo_revision": "production", 20:12:03 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 20:12:03 INFO - "repository": "", 20:12:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 20:12:03 INFO - "buildid": "20160718082858", 20:12:03 INFO - "pgo_build": "False", 20:12:03 INFO - "basedir": "/builds/slave/test", 20:12:03 INFO - "buildnumber": 47, 20:12:03 INFO - "slavename": "t-yosemite-r7-0345", 20:12:03 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 20:12:03 INFO - "platform": "yosemite_r7", 20:12:03 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:12:03 INFO - "branch": "mozilla-beta", 20:12:03 INFO - "repo_path": "releases/mozilla-beta", 20:12:03 INFO - "revision": "0f4257230dffa106e90cf736df9dbe9859ac5274", 20:12:03 INFO - "stage_platform": "macosx64", 20:12:03 INFO - "builduid": "45ab1cec1c9e4d789d92b52f048d1303", 20:12:03 INFO - "slavebuilddir": "test" 20:12:03 INFO - } 20:12:03 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg. 20:12:03 INFO - Running post-action listener: _resource_record_post_action 20:12:03 INFO - ##### 20:12:03 INFO - ##### Running download-and-extract step. 20:12:03 INFO - ##### 20:12:03 INFO - Running pre-action listener: _resource_record_pre_action 20:12:03 INFO - Running main action method: download_and_extract 20:12:03 INFO - mkdir: /builds/slave/test/build/tests 20:12: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')]} 20:12:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.test_packages.json 20:12:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/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 20:12:03 INFO - Downloaded 1165 bytes. 20:12:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:12:03 INFO - Using the following test package requirements: 20:12:03 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:12:03 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:12:03 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 20:12:03 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:12:03 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 20:12:03 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:12:03 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:12:03 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 20:12:03 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:12:03 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:12:03 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 20:12:03 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:12:03 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 20:12:03 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:12:03 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 20:12:03 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:12:03 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 20:12:03 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 20:12: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')]} 20:12:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.common.tests.zip 20:12:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 20:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/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 20:12:03 INFO - Downloaded 18314732 bytes. 20:12:03 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'] 20:12:03 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 20:12:06 INFO - Return code: 0 20:12:06 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 20:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.common.tests.zip 20:12:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 20:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/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 20:12:07 INFO - Downloaded 18314732 bytes. 20:12:07 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'] 20:12:07 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 20:12:10 INFO - Return code: 0 20:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:10 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.talos.tests.zip 20:12:10 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 20:12:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/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 20:12:11 INFO - Downloaded 10840145 bytes. 20:12:11 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'] 20:12:11 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 20:12:11 INFO - Return code: 0 20:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:11 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg 20:12:11 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 20:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 20:12:12 INFO - Downloaded 86193191 bytes. 20:12:12 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg 20:12:12 INFO - mkdir: /builds/slave/test/properties 20:12:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:12:12 INFO - Writing to file /builds/slave/test/properties/build_url 20:12:12 INFO - Contents: 20:12:12 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg 20:12:12 INFO - Running post-action listener: _resource_record_post_action 20:12:12 INFO - Running post-action listener: set_extra_try_arguments 20:12:12 INFO - ##### 20:12:12 INFO - ##### Running populate-webroot step. 20:12:12 INFO - ##### 20:12:12 INFO - Running pre-action listener: _resource_record_pre_action 20:12:12 INFO - Running main action method: populate_webroot 20:12:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:12:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:12:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:12:12 INFO - '--tppagecycles', 20:12:12 INFO - '7'], 20:12:12 INFO - 'tests': ['tsvgm']}}, 20:12:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:12:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:12:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:12:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:12:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:12:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:12:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:12 INFO - 'talos_options': ['--disable-e10s'], 20:12:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:12:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:12:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:12 INFO - 'talos_options': ['--disable-e10s'], 20:12:12 INFO - 'tests': ['damp', 'tps']}, 20:12:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:12 INFO - 'tests': ['damp', 'tps']}, 20:12:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:12:12 INFO - 'tests': ['dromaeo_dom']}, 20:12:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:12:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:12:12 INFO - 'tests': ['a11yr', 20:12:12 INFO - 'ts_paint', 20:12:12 INFO - 'tpaint', 20:12:12 INFO - 'sessionrestore', 20:12:12 INFO - 'sessionrestore_no_auto_restore', 20:12:12 INFO - 'tabpaint']}, 20:12:12 INFO - 'other-e10s': {'tests': ['a11yr', 20:12:12 INFO - 'ts_paint', 20:12:12 INFO - 'tpaint', 20:12:12 INFO - 'sessionrestore', 20:12:12 INFO - 'sessionrestore_no_auto_restore', 20:12:12 INFO - 'tabpaint']}, 20:12:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:12:12 INFO - 'ts_paint', 20:12:12 INFO - 'tpaint', 20:12:12 INFO - 'sessionrestore', 20:12:12 INFO - 'sessionrestore_no_auto_restore', 20:12:12 INFO - 'tabpaint']}, 20:12:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:12:12 INFO - 'ts_paint', 20:12:12 INFO - 'tpaint', 20:12:12 INFO - 'sessionrestore', 20:12:12 INFO - 'sessionrestore_no_auto_restore', 20:12:12 INFO - 'tabpaint']}, 20:12:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:12:12 INFO - 'tests': ['a11yr', 20:12:12 INFO - 'ts_paint', 20:12:12 INFO - 'tpaint', 20:12:12 INFO - 'sessionrestore', 20:12:12 INFO - 'sessionrestore_no_auto_restore', 20:12:12 INFO - 'tabpaint']}, 20:12:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:12:12 INFO - 'tests': ['a11yr', 20:12:12 INFO - 'ts_paint', 20:12:12 INFO - 'tpaint', 20:12:12 INFO - 'sessionrestore', 20:12:12 INFO - 'sessionrestore_no_auto_restore', 20:12:12 INFO - 'tabpaint']}, 20:12:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:12:12 INFO - 'tests': ['tsvgx', 20:12:12 INFO - 'tsvgr_opacity', 20:12:12 INFO - 'tart', 20:12:12 INFO - 'tscrollx', 20:12:12 INFO - 'cart']}, 20:12:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:12:12 INFO - 'tsvgr_opacity', 20:12:12 INFO - 'tart', 20:12:12 INFO - 'tscrollx', 20:12:12 INFO - 'cart']}, 20:12:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:12 INFO - 'talos_options': ['--disable-e10s'], 20:12:12 INFO - 'tests': ['tp5o']}, 20:12:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:12 INFO - 'tests': ['tp5o']}, 20:12:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:12 INFO - 'talos_options': ['--disable-e10s', 20:12:12 INFO - '--xperf_path', 20:12:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:12:12 INFO - 'tests': ['tp5n']}, 20:12:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:12 INFO - 'talos_options': ['--xperf_path', 20:12:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:12:12 INFO - 'tests': ['tp5n']}}, 20:12:12 INFO - 'talos.zip': {'path': '', 20:12:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:12:12 INFO - Running post-action listener: _resource_record_post_action 20:12:12 INFO - ##### 20:12:12 INFO - ##### Running create-virtualenv step. 20:12:12 INFO - ##### 20:12:12 INFO - Running pre-action listener: _resource_record_pre_action 20:12:12 INFO - Running main action method: create_virtualenv 20:12:12 INFO - Creating virtualenv /builds/slave/test/build/venv 20:12:12 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 20:12:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:12:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:12:12 INFO - Using real prefix '/tools/python27' 20:12:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:12:13 INFO - Installing distribute.............................................................................................................................................................................................done. 20:12:16 INFO - Installing pip.................done. 20:12:16 INFO - Return code: 0 20:12:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:16 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 0x102cbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ccb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c60fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b5ae00>, '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 0x1029c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b55b20>, '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.RTo9gmTu0O/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.0LQABS8mqy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 20:12:16 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 20:12:16 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 20:12:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RTo9gmTu0O/Render', 20:12:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:16 INFO - 'HOME': '/Users/cltbld', 20:12:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:16 INFO - 'LOGNAME': 'cltbld', 20:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:16 INFO - 'MOZ_NO_REMOTE': '1', 20:12:16 INFO - 'NO_EM_RESTART': '1', 20:12:16 INFO - 'PAGER': '/bin/cat', 20:12:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:16 INFO - 'PWD': '/builds/slave/test', 20:12:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:16 INFO - 'SHELL': '/bin/bash', 20:12:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LQABS8mqy/Listeners', 20:12:16 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 20:12:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:16 INFO - 'USER': 'cltbld', 20:12:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:16 INFO - 'XPC_FLAGS': '0x0', 20:12:16 INFO - 'XPC_SERVICE_NAME': '0', 20:12:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:16 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 20:12:16 INFO - Cleaning up... 20:12:16 INFO - Return code: 0 20:12:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:16 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 0x102cbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ccb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c60fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b5ae00>, '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 0x1029c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b55b20>, '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.RTo9gmTu0O/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.0LQABS8mqy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 20:12:16 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 20:12:16 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 20:12:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RTo9gmTu0O/Render', 20:12:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:16 INFO - 'HOME': '/Users/cltbld', 20:12:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:16 INFO - 'LOGNAME': 'cltbld', 20:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:16 INFO - 'MOZ_NO_REMOTE': '1', 20:12:16 INFO - 'NO_EM_RESTART': '1', 20:12:16 INFO - 'PAGER': '/bin/cat', 20:12:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:16 INFO - 'PWD': '/builds/slave/test', 20:12:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:16 INFO - 'SHELL': '/bin/bash', 20:12:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LQABS8mqy/Listeners', 20:12:16 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 20:12:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:16 INFO - 'USER': 'cltbld', 20:12:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:16 INFO - 'XPC_FLAGS': '0x0', 20:12:16 INFO - 'XPC_SERVICE_NAME': '0', 20:12:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:16 INFO - Downloading/unpacking psutil>=0.7.1 20:12:16 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 20:12:16 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 20:12:16 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 20:12:16 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 20:12:16 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 20:12:16 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 20:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:12:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:12:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:12:20 INFO - Installing collected packages: psutil 20:12:20 INFO - Running setup.py install for psutil 20:12:20 INFO - building 'psutil._psutil_osx' extension 20:12:20 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 20:12:20 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 20:12:20 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 20:12:20 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 20:12:21 INFO - building 'psutil._psutil_posix' extension 20:12:21 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 20:12:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:12:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:12:21 INFO - ^ 20:12:21 INFO - 1 warning generated. 20:12:21 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 20:12:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:12:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:12:21 INFO - Successfully installed psutil 20:12:21 INFO - Cleaning up... 20:12:21 INFO - Return code: 0 20:12:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:12:21 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')]} 20:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:21 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')]} 20:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:21 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 0x102cbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ccb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c60fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b5ae00>, '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 0x1029c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b55b20>, '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.RTo9gmTu0O/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.0LQABS8mqy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 20:12:21 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 20:12:21 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 20:12:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RTo9gmTu0O/Render', 20:12:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:21 INFO - 'HOME': '/Users/cltbld', 20:12:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:21 INFO - 'LOGNAME': 'cltbld', 20:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:21 INFO - 'MOZ_NO_REMOTE': '1', 20:12:21 INFO - 'NO_EM_RESTART': '1', 20:12:21 INFO - 'PAGER': '/bin/cat', 20:12:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:21 INFO - 'PWD': '/builds/slave/test', 20:12:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:21 INFO - 'SHELL': '/bin/bash', 20:12:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LQABS8mqy/Listeners', 20:12:21 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 20:12:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:21 INFO - 'USER': 'cltbld', 20:12:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:21 INFO - 'XPC_FLAGS': '0x0', 20:12:21 INFO - 'XPC_SERVICE_NAME': '0', 20:12:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:12:21 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 20:12:21 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 20:12:21 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 20:12:21 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 20:12:21 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 20:12:21 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 20:12:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:12:24 INFO - Installing collected packages: mozsystemmonitor 20:12:24 INFO - Running setup.py install for mozsystemmonitor 20:12:24 INFO - Successfully installed mozsystemmonitor 20:12:24 INFO - Cleaning up... 20:12:24 INFO - Return code: 0 20:12:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:12:24 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')]} 20:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:24 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')]} 20:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:24 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 0x102cbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ccb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c60fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b5ae00>, '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 0x1029c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b55b20>, '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.RTo9gmTu0O/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.0LQABS8mqy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 20:12:24 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 20:12:24 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 20:12:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RTo9gmTu0O/Render', 20:12:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:24 INFO - 'HOME': '/Users/cltbld', 20:12:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:24 INFO - 'LOGNAME': 'cltbld', 20:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:24 INFO - 'MOZ_NO_REMOTE': '1', 20:12:24 INFO - 'NO_EM_RESTART': '1', 20:12:24 INFO - 'PAGER': '/bin/cat', 20:12:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:24 INFO - 'PWD': '/builds/slave/test', 20:12:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:24 INFO - 'SHELL': '/bin/bash', 20:12:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LQABS8mqy/Listeners', 20:12:24 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 20:12:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:24 INFO - 'USER': 'cltbld', 20:12:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:24 INFO - 'XPC_FLAGS': '0x0', 20:12:24 INFO - 'XPC_SERVICE_NAME': '0', 20:12:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:24 INFO - Downloading/unpacking blobuploader==1.2.4 20:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:27 INFO - Downloading blobuploader-1.2.4.tar.gz 20:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:12:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:12:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:12:28 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 20:12:28 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 20:12:28 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 20:12:28 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 20:12:28 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 20:12:28 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 20:12:28 INFO - Downloading docopt-0.6.1.tar.gz 20:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:12:28 INFO - Installing collected packages: blobuploader, requests, docopt 20:12:28 INFO - Running setup.py install for blobuploader 20:12:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:12:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:12:28 INFO - Running setup.py install for requests 20:12:29 INFO - Running setup.py install for docopt 20:12:29 INFO - Successfully installed blobuploader requests docopt 20:12:29 INFO - Cleaning up... 20:12:29 INFO - Return code: 0 20:12:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:29 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')]} 20:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:29 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')]} 20:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:29 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 0x102cbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ccb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c60fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b5ae00>, '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 0x1029c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b55b20>, '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.RTo9gmTu0O/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.0LQABS8mqy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 20:12:29 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 20:12:29 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 20:12:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RTo9gmTu0O/Render', 20:12:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:29 INFO - 'HOME': '/Users/cltbld', 20:12:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:29 INFO - 'LOGNAME': 'cltbld', 20:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:29 INFO - 'MOZ_NO_REMOTE': '1', 20:12:29 INFO - 'NO_EM_RESTART': '1', 20:12:29 INFO - 'PAGER': '/bin/cat', 20:12:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:29 INFO - 'PWD': '/builds/slave/test', 20:12:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:29 INFO - 'SHELL': '/bin/bash', 20:12:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LQABS8mqy/Listeners', 20:12:29 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 20:12:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:29 INFO - 'USER': 'cltbld', 20:12:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:29 INFO - 'XPC_FLAGS': '0x0', 20:12:29 INFO - 'XPC_SERVICE_NAME': '0', 20:12:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:12:29 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Uld0Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:12:29 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-fTgxqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:12:29 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-URIcVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:12:29 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-7DA7fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:12:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-DYu11T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:12:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-xd5_rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:12:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-LQ0JHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:12:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-tAKNhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:12:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-25jcJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:12:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-WZtpYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:12:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-fFt54r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:12:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-0U2z_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:12:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-C0JyGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:12:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-V8tAue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:31 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-u8WsN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:12:31 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-gjXjM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:12:31 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-lxBLkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:12:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:12:31 INFO - Running setup.py install for manifestparser 20:12:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:12:31 INFO - Running setup.py install for mozcrash 20:12:31 INFO - Running setup.py install for mozdebug 20:12:31 INFO - Running setup.py install for mozdevice 20:12:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:12:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:12:31 INFO - Running setup.py install for mozfile 20:12:32 INFO - Running setup.py install for mozhttpd 20:12:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:12:32 INFO - Running setup.py install for mozinfo 20:12:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:12:32 INFO - Running setup.py install for mozInstall 20:12:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:12:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:12:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:12:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:12:32 INFO - Running setup.py install for mozleak 20:12:32 INFO - Running setup.py install for mozlog 20:12:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:12:32 INFO - Running setup.py install for moznetwork 20:12:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:12:32 INFO - Running setup.py install for mozprocess 20:12:33 INFO - Running setup.py install for mozprofile 20:12:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:12:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:12:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:12:33 INFO - Running setup.py install for mozrunner 20:12:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:12:33 INFO - Running setup.py install for mozscreenshot 20:12:33 INFO - Running setup.py install for moztest 20:12:33 INFO - Running setup.py install for mozversion 20:12:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:12:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:12:33 INFO - Cleaning up... 20:12:33 INFO - Return code: 0 20:12:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:33 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 0x102cbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ccb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c60fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b5ae00>, '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 0x1029c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b55b20>, '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.RTo9gmTu0O/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.0LQABS8mqy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 20:12:33 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 20:12:33 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 20:12:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RTo9gmTu0O/Render', 20:12:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:33 INFO - 'HOME': '/Users/cltbld', 20:12:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:33 INFO - 'LOGNAME': 'cltbld', 20:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:33 INFO - 'MOZ_NO_REMOTE': '1', 20:12:33 INFO - 'NO_EM_RESTART': '1', 20:12:33 INFO - 'PAGER': '/bin/cat', 20:12:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:33 INFO - 'PWD': '/builds/slave/test', 20:12:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:33 INFO - 'SHELL': '/bin/bash', 20:12:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LQABS8mqy/Listeners', 20:12:33 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 20:12:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:33 INFO - 'USER': 'cltbld', 20:12:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:33 INFO - 'XPC_FLAGS': '0x0', 20:12:33 INFO - 'XPC_SERVICE_NAME': '0', 20:12:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:12:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Zq_Puv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:12:34 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)) 20:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:12:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-goaMi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:12:34 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)) 20:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:12:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-1a2c5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:12:34 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)) 20:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:12:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-n9nqBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:12:34 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)) 20:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:12:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-9rgIlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:12:34 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)) 20:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:12:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-0RqSi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:12:34 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)) 20:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:12:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-jtu2QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:12:34 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)) 20:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:12:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-pCUaLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:12:35 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)) 20:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:12:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-BTFhzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:12:35 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)) 20:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:12:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-HcA7vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:12:35 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)) 20:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:12:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Z0ZVKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:12:35 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)) 20:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:12:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-1syfrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:12:35 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)) 20:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:12:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-0IKYwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:12:35 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)) 20:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:12:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-cX1cRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:12:35 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)) 20:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ET7m2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:35 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)) 20:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:12:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-4lw4KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:12:35 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)) 20:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:12:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-BvX0qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:12:35 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)) 20:12:35 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)) 20:12:35 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)) 20:12:35 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)) 20:12:35 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)) 20:12:35 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)) 20:12:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:38 INFO - Downloading blessings-1.6.tar.gz 20:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:12:38 INFO - Installing collected packages: blessings 20:12:38 INFO - Running setup.py install for blessings 20:12:38 INFO - Successfully installed blessings 20:12:38 INFO - Cleaning up... 20:12:38 INFO - Return code: 0 20:12:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:12:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:39 INFO - Reading from file tmpfile_stdout 20:12:39 INFO - Current package versions: 20:12:39 INFO - blessings == 1.6 20:12:39 INFO - blobuploader == 1.2.4 20:12:39 INFO - docopt == 0.6.1 20:12:39 INFO - manifestparser == 1.1 20:12:39 INFO - mozInstall == 1.12 20:12:39 INFO - mozcrash == 0.17 20:12:39 INFO - mozdebug == 0.1 20:12:39 INFO - mozdevice == 0.48 20:12:39 INFO - mozfile == 1.2 20:12:39 INFO - mozhttpd == 0.7 20:12:39 INFO - mozinfo == 0.9 20:12:39 INFO - mozleak == 0.1 20:12:39 INFO - mozlog == 3.1 20:12:39 INFO - moznetwork == 0.27 20:12:39 INFO - mozprocess == 0.22 20:12:39 INFO - mozprofile == 0.28 20:12:39 INFO - mozrunner == 6.11 20:12:39 INFO - mozscreenshot == 0.1 20:12:39 INFO - mozsystemmonitor == 0.0 20:12:39 INFO - moztest == 0.7 20:12:39 INFO - mozversion == 1.4 20:12:39 INFO - psutil == 3.1.1 20:12:39 INFO - requests == 1.2.3 20:12:39 INFO - wsgiref == 0.1.2 20:12:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:39 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 0x102cbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ccb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c60fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b5ae00>, '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 0x1029c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b55b20>, '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.RTo9gmTu0O/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.0LQABS8mqy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 20:12:39 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 20:12:39 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 20:12:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RTo9gmTu0O/Render', 20:12:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:39 INFO - 'HOME': '/Users/cltbld', 20:12:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:39 INFO - 'LOGNAME': 'cltbld', 20:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:39 INFO - 'MOZ_NO_REMOTE': '1', 20:12:39 INFO - 'NO_EM_RESTART': '1', 20:12:39 INFO - 'PAGER': '/bin/cat', 20:12:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:39 INFO - 'PWD': '/builds/slave/test', 20:12:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:39 INFO - 'SHELL': '/bin/bash', 20:12:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LQABS8mqy/Listeners', 20:12:39 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 20:12:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:39 INFO - 'USER': 'cltbld', 20:12:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:39 INFO - 'XPC_FLAGS': '0x0', 20:12:39 INFO - 'XPC_SERVICE_NAME': '0', 20:12:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:39 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)) 20:12:39 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)) 20:12:39 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)) 20:12:39 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)) 20:12:39 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)) 20:12:39 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)) 20:12:39 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)) 20:12:39 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)) 20:12:39 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)) 20:12:39 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)) 20:12:39 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)) 20:12:39 INFO - Cleaning up... 20:12:39 INFO - Return code: 0 20:12:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:39 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 0x102cbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ccb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c60fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b5ae00>, '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 0x1029c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b55b20>, '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.RTo9gmTu0O/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.0LQABS8mqy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 20:12:39 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 20:12:39 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 20:12:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RTo9gmTu0O/Render', 20:12:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:39 INFO - 'HOME': '/Users/cltbld', 20:12:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:39 INFO - 'LOGNAME': 'cltbld', 20:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:39 INFO - 'MOZ_NO_REMOTE': '1', 20:12:39 INFO - 'NO_EM_RESTART': '1', 20:12:39 INFO - 'PAGER': '/bin/cat', 20:12:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:39 INFO - 'PWD': '/builds/slave/test', 20:12:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:39 INFO - 'SHELL': '/bin/bash', 20:12:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LQABS8mqy/Listeners', 20:12:39 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 20:12:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:39 INFO - 'USER': 'cltbld', 20:12:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:39 INFO - 'XPC_FLAGS': '0x0', 20:12:39 INFO - 'XPC_SERVICE_NAME': '0', 20:12:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:39 INFO - Downloading/unpacking jsonschema 20:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:12:43 INFO - Downloading/unpacking functools32 (from jsonschema) 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:43 INFO - Downloading functools32-3.2.3-2.tar.gz 20:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:12:43 INFO - warning: no files found matching '*.txt' 20:12:43 INFO - no previously-included directories found matching 'build' 20:12:43 INFO - no previously-included directories found matching 'dist' 20:12:43 INFO - no previously-included directories found matching '.git*' 20:12:43 INFO - Installing collected packages: jsonschema, functools32 20:12:43 INFO - Running setup.py install for functools32 20:12:43 INFO - warning: no files found matching '*.txt' 20:12:43 INFO - no previously-included directories found matching 'build' 20:12:43 INFO - no previously-included directories found matching 'dist' 20:12:43 INFO - no previously-included directories found matching '.git*' 20:12:43 INFO - Successfully installed jsonschema functools32 20:12:43 INFO - Cleaning up... 20:12:43 INFO - Return code: 0 20:12:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:43 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 0x102cbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ccb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c60fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b5ae00>, '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 0x1029c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b55b20>, '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.RTo9gmTu0O/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.0LQABS8mqy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 20:12:43 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 20:12:43 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 20:12:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RTo9gmTu0O/Render', 20:12:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:43 INFO - 'HOME': '/Users/cltbld', 20:12:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:43 INFO - 'LOGNAME': 'cltbld', 20:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:43 INFO - 'MOZ_NO_REMOTE': '1', 20:12:43 INFO - 'NO_EM_RESTART': '1', 20:12:43 INFO - 'PAGER': '/bin/cat', 20:12:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:43 INFO - 'PWD': '/builds/slave/test', 20:12:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:43 INFO - 'SHELL': '/bin/bash', 20:12:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LQABS8mqy/Listeners', 20:12:43 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 20:12:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:43 INFO - 'USER': 'cltbld', 20:12:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:43 INFO - 'XPC_FLAGS': '0x0', 20:12:43 INFO - 'XPC_SERVICE_NAME': '0', 20:12:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:44 INFO - Downloading/unpacking flake8 20:12:44 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 20:12:44 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 20:12:44 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 20:12:44 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 20:12:44 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 20:12:44 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 20:12:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:12:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:12:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:12:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:12:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:12:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:12:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:12:47 INFO - no previously-included directories found matching 'docs/_build' 20:12:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:12:47 INFO - Running setup.py install for pep8 20:12:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:12:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:12:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:12:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:12:48 INFO - no previously-included directories found matching 'docs/_build' 20:12:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:12:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:12:48 INFO - Cleaning up... 20:12:48 INFO - Return code: 0 20:12:48 INFO - Running post-action listener: _resource_record_post_action 20:12:48 INFO - Running post-action listener: _start_resource_monitoring 20:12:48 INFO - Starting resource monitoring. 20:12:48 INFO - ##### 20:12:48 INFO - ##### Running install step. 20:12:48 INFO - ##### 20:12:48 INFO - Running pre-action listener: _resource_record_pre_action 20:12:48 INFO - Running main action method: install 20:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:48 INFO - Reading from file tmpfile_stdout 20:12:48 INFO - Detecting whether we're running mozinstall >=1.0... 20:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:12:48 INFO - Reading from file tmpfile_stdout 20:12:48 INFO - Output received: 20:12:48 INFO - Usage: mozinstall [options] installer 20:12:48 INFO - Options: 20:12:48 INFO - -h, --help show this help message and exit 20:12:48 INFO - -d DEST, --destination=DEST 20:12:48 INFO - Directory to install application into. [default: 20:12:48 INFO - "/builds/slave/test"] 20:12:48 INFO - --app=APP Application being installed. [default: firefox] 20:12:48 INFO - mkdir: /builds/slave/test/build/application 20:12:48 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'] 20:12:48 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 20:13:10 INFO - Reading from file tmpfile_stdout 20:13:10 INFO - Output received: 20:13:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:13:10 INFO - Running post-action listener: _resource_record_post_action 20:13:10 INFO - ##### 20:13:10 INFO - ##### Running run-tests step. 20:13:10 INFO - ##### 20:13:10 INFO - Running pre-action listener: _resource_record_pre_action 20:13:10 INFO - Running main action method: run_tests 20:13:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:13:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:13:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:13:10 INFO - 2016-07-18 20:13:10.621 screenresolution[1639:7299] starting screenresolution argv=screenresolution get 20:13:10 INFO - 2016-07-18 20:13:10.623 screenresolution[1639:7299] Display 0: 1600x1200x32@60 20:13:10 INFO - 2016-07-18 20:13:10.629 screenresolution[1640:7301] starting screenresolution argv=screenresolution list 20:13:10 INFO - Available Modes on Display 0 20:13:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:13:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:13:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:13:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:13:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:13:10 INFO - Intel Iris: 20:13:10 INFO - Chipset Model: Intel Iris 20:13:10 INFO - Type: GPU 20:13:10 INFO - Bus: Built-In 20:13:10 INFO - VRAM (Dynamic, Max): 1536 MB 20:13:10 INFO - Vendor: Intel (0x8086) 20:13:10 INFO - Device ID: 0x0a2e 20:13:10 INFO - Revision ID: 0x0009 20:13:10 INFO - Displays: 20:13:10 INFO - Display: 20:13:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:13:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:13:10 INFO - Display Serial Number: 1600x1200 60 20:13:10 INFO - Main Display: Yes 20:13:10 INFO - Mirror: Off 20:13:10 INFO - Online: Yes 20:13:10 INFO - Rotation: Supported 20:13:10 INFO - Return code: 0 20:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:13:10 INFO - Python 2.7.3 20:13:10 INFO - Return code: 0 20:13:10 INFO - grabbing minidump binary from tooltool 20:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:10 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 0x102b5ae00>, '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 0x1029c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b55b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:13:10 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 20:13:10 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 20:13:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:13:10 INFO - Return code: 0 20:13:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:13:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:13:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:13:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:13:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:13:12 INFO - Return code: 0 20:13:12 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/1468855738/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--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 20:13:12 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/1468855738/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0345 --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 20:13:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RTo9gmTu0O/Render', 20:13:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:13:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:13:12 INFO - 'HOME': '/Users/cltbld', 20:13:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:13:12 INFO - 'LOGNAME': 'cltbld', 20:13:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:13:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:12 INFO - 'MOZ_NO_REMOTE': '1', 20:13:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:13:12 INFO - 'NO_EM_RESTART': '1', 20:13:12 INFO - 'PAGER': '/bin/cat', 20:13:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:12 INFO - 'PWD': '/builds/slave/test', 20:13:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:13:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:13:12 INFO - 'SHELL': '/bin/bash', 20:13:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LQABS8mqy/Listeners', 20:13:12 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 20:13:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:13:12 INFO - 'USER': 'cltbld', 20:13:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:13:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:12 INFO - 'XPC_FLAGS': '0x0', 20:13:12 INFO - 'XPC_SERVICE_NAME': '0', 20:13:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:13:12 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/1468855738/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--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 20:13:12 INFO - mozversion application_buildid: 20160718082858 20:13:12 INFO - mozversion application_changeset: 0f4257230dffa106e90cf736df9dbe9859ac5274 20:13:12 INFO - mozversion application_display_name: Firefox 20:13:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:13:12 INFO - mozversion application_name: Firefox 20:13:12 INFO - mozversion application_remotingname: firefox 20:13:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:13:12 INFO - mozversion application_vendor: Mozilla 20:13:12 INFO - mozversion application_version: 48.0 20:13:12 INFO - mozversion platform_buildid: 20160718082858 20:13:12 INFO - mozversion platform_changeset: 0f4257230dffa106e90cf736df9dbe9859ac5274 20:13:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:13:12 INFO - mozversion platform_version: 48.0 20:13:12 INFO - using testdate: 1468897992 20:13:12 INFO - actual date: 1468897992 20:13:12 INFO - starting webserver on 'localhost:49264' 20:13:12 INFO - SUITE-START | Running 2 tests 20:13:12 INFO - TEST-START | dromaeo_css 20:13:12 INFO - operating with platform_type : mac_ 20:13:12 INFO - Initialising browser for dromaeo_css test... 20:13:12 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmp7LVquS/profile http://localhost:49264/getInfo.html) 20:13:14 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 20:13:14 INFO - PROCESS | 1658 | colorDepth:24 20:13:14 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 20:13:14 INFO - PROCESS | 1658 | __metrics 20:13:14 INFO - PROCESS | 1658 | 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" 20:13:14 ERROR - PROCESS | 1658 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:13:15 INFO - TEST-INFO | 1658: exit 0 20:13:15 INFO - Browser initialized. 20:13:15 INFO - Running cycle 1/1 for dromaeo_css test... 20:13:15 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmp7LVquS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:13:27 INFO - PROCESS | 1661 | RSS: Main: 160280576 20:13:27 INFO - PROCESS | 1661 | 20:14:18 INFO - PROCESS | 1661 | 1468898058520 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] 20:16:28 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 20:16:29 INFO - PROCESS | 1661 | RSS: Main: 249307136 20:16:29 INFO - PROCESS | 1661 | 20:19:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 20:19:33 INFO - PROCESS | 1661 | RSS: Main: 311234560 20:19:33 INFO - PROCESS | 1661 | 20:22:35 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 20:22:35 INFO - PROCESS | 1661 | RSS: Main: 312238080 20:22:35 INFO - PROCESS | 1661 | 20:25:37 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 20:25:38 INFO - PROCESS | 1661 | RSS: Main: 307113984 20:25:38 INFO - PROCESS | 1661 | 20:28:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 20:28:42 INFO - PROCESS | 1661 | RSS: Main: 272211968 20:28:42 INFO - PROCESS | 1661 | 20:31:44 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 20:31:44 INFO - PROCESS | 1661 | RSS: Main: 319631360 20:31:44 INFO - PROCESS | 1661 | 20:31:44 INFO - PROCESS | 1661 | __start_tp_report 20:31:44 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 20:31:44 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 20:31:44 INFO - PROCESS | 1661 | |i|pagename|runs| 20:31:44 INFO - PROCESS | 1661 | |0;dojo.html;3525.2596954639525;3613.8554457821688;3629.256002519483;3637;3700.4449332600107;5965.045592705168;5991.910121348178;6006.346553662198;6030.849228769277;6037.909431358533;4594.72431654101;5443.564514838813;5983.58114931955;5990.970045149779;5991;5289.18017707256;5333.946660533384;5337.386200586943;5361.571074314045;5430.728463576806;5368.651037682557;5425.484578964992;5426.538744206747;5430.321209848769;5431.511163995239;4324.286492728712;5304.151335786275;5345.786168553253;5382.327209098863;5389.407165211824;5426.9185962210595;5440.183972404131;5441.755121019563;5466.371367292732;5484.314460692413;5187.974060129713;5238.816641417532;5361.008213480519;5367.355917289911;5373.892522149535;5745.195672605839;5802.564807639444;5805.941940580582;5806.506446951972;5846.035404158309;6371.23545174582;6375.043743438475;6385.904211436786;6390.233172019387;6408.134901788246;6300.590461620026;6317.715702793339;6367.426931576134;6385.968070159666;6386.744530218785;6079.179310792986;6081.158581894102;6086.969565152146;6089.908651370233;6116.1437398763765;6413.070104834773;6420.390062944013;6421.068945002949;6423.293437721847;6439.54923155384;6217.160683307786;6228.813135605939;6310.1481300024825;6334.588251763713;6389.6805159741825;6342.968285158545;6361.713722882481;6364.745410183541;6364.840878978062;6391.776287829904;6331.746730130835;6384.6169229846355;6385.29761726219;6399.488040956712;6404.135441715309;6294.496440284766;6317.778877739257;6367.076773867763;6403.359664033653;6407.13503677007;5050.823221187241;5070.974645126751;5078.619103567247;5104.285400043997;5105.132127538327;4539.387182730356;4542.818287268472;4544.227481328182;4546.40896683429;4548.7725613719185;5923.614965027259;5951.077582974646;6042.728077236535;6056.152138700585;6083.6045657032155;6302.306746257908;6344.048392741126;6344.270408903035;6360.491160707133;6363.681815909186;6027.939720602738;6061.151438798572;6070.119832624245;6077.604955677867;6081.7871374502565;5493.7802487900035;5562.721863906789;5570.220169176318;5581.469760372758;5606.719664016864;5429.592780541475;6400.583962042452;6469.029645553111;6469.159009328757;6471.676416179078;6323.367663233824;6330.936690633035;6337.334579869047;6341.985282354801;6343.016832390987;6354.301026886947;6477.125588045554;6479.352064793483;6481.449076828522;6488.740450381932;6282.685865706788;6332.461740752087;6375.075614036032;6403.551751377358;6413.518986076157;6328.240611126695;6346.270178929482;6346.873062538631;6348.269948955744;6363.300036996019;6174.8147555573405;6200.3489633589625;6312.154765053095;6381.457576106083;6406.167198264196;6297.779577714758;6356.618602883842;6376.713047912763;6382.074599183;6404.391582799627;6194;6241.843953901189;6243.875122497434;6249.468795152463;6261.906071408841;6211.9689401552705;6213.161223234805;6361.332060133619;6362.395572420613;6378.872422551616;5296.781740199853;6242.126102345766;6249.0626406039455;6254;6260.718267677874 20:31:44 INFO - PROCESS | 1661 | |1;ext.html;515.0805811626248;553.9362973258075;559.9696558332668;569.0922977850328;576.780823287151;33368.66631333689;38559;39430;39457.802710986405;39469.605303946955;43002.56997430025;43406;43428.56571434285;43463.91340216496;43470.91322716934;8987.281017518582;9574.138327550536;9796.902030979705;9808.950955245215;11450.885491145065;11586.304821710683;11722.472488737985;11723;11736.237144585617;11741.823872641917;11637.883621163806;11682.474288656987;11687.883121168807;11693.356865372401;11725.413729313543;11556.82664760025;11662.358570278631;11664.125190610737;11677.299362038262;11677.532898684043;11524.59663911759;11637.418129093512;11645.243059201124;11917.404129793562;11930.940345298304;41362.79318603418;41654.1669166618;41659.791701041606;41776.37335439971;42322.365164522555;3277.2134687675025;3324.6675332466803;3329.4886962720143;3388.1868351595685;3399.1672040350027;27900.860495697594;28411.147665570064;29009.709902901122;29648.555271670943;30222.942197023218;2739.917802465929;2779.069011881022;2824.138637715496;2833.39082097348;2867.627208462907;521571;527529;527572;527903;529119;37897.62102378941;38432.8078359612;38503;64315.67842160853;65143;36661.083472912855;36915;37004.629953700656;37007;37047.629523704956;15895.284712187979;16014.279357428944;16047.839521604868;16082.276297566637;16092.839071609369;12826.9358653208;12829.422675979604;12831.615051548468;12843.422046007765;13878.375473103735;7309.5248808827255;8342.332613390914;8374.623141958504;8420.073791883011;8453.49279043247;3430.8970730878113;3465.70541503975;3466.3240668069484;3472.618012018676;3507.5790905091044;1023.4933707814531;1042.166266986423;1042.2339580408393;1069.5989004123453;1139.5783560082657;24623.50752984966;29467.410651786846;30867;31332.843335783175;31483.84258078695;1071.7159952612565;1136.420425582942;1189.6609466302236;1205.2768338996532;1311.4557458654742;15668.903176777743;15685.529434116996;15789.526314210363;15996.360145594279;16054.27755750994;625402;626513;637497.6250237438;638468;639894.8005259944;62369.68815155986;63208;63304;63320.683396582725;63346;1462.6050966239056;1500.2273828978084;1588.9126098064487;1596.074276919407;1651.347717651521;29458;29653.25866853346;29871.850640746656;30025.849870750506;30337.696623033487;47089.764551177024;47182;47747.761261193475;47876.7606161967;47934.52065479301;436052;436839;437039.814800924;437238;444813;24271.029158833448;27508.58737118985;27983.58024629673;28364.85817570899;28405.43189136247;42923;43726.12547749091;44164.55835441733;44967;44971;35693.64306357007;36336.4549531752;36407;36441;37119.44320835135;35726.821365893;35990.28019439649;36118;36528.634713653584;38087.80956095202;36826.447603286506;36947.07632309106;37304.25391492209;38281.6171838278;38645.6135438642;32620.673793261765;33391.165220869676;33499.665003349655;33516.329673406886;33580.664193357756;21899.562008760055;24834.25497235086;24983;25059.62172080553;25289.367765806 20:31:44 INFO - PROCESS | 1661 | |2;jquery.html;409.94875640544933;414.446713637294;415.65085328324204;416.25698128840025;423.5087298733468;15149.545513634608;20287.08708108135;20858.95705214739;20882.477938051536;20910.790892091114;20396.694049589267;20751.481212969684;21050.89474552629;21115.57768844622;21142.15431382743;5805.071188609823;5911.497522710564;6013.458788709016;6016.608920420181;6023.879522409571;5877.794277200299;5971.4625683688455;5971.522278217754;5977.282726072855;5978.730957106941;4374.671899607526;5553.750081246354;5566;6251.593646412991;6539.934600654004;6426.871462570769;6495.220573531183;6505.674716264168;6517.804465866008;6518.576292540994;5524.475174858382;5635.6618602883955;5661.235733176051;5661.745221465044;5666.631668941505;24119.2764217072;24513.509729805304;24834.758262086823;25331.366715832068;25340.746592534022;2271.943201419961;2286.45125169958;2311.6070268054305;2327.0691723310642;2353.705786776653;12137.575184868487;14822.40710371584;14878.70242595153;15176.317065732068;15222.771658425132;1786.7855857297207;1824.2520566567775;1848.7134494153427;1878.5679293762375;1893.1764682363216;99001;102118;103616.48191759069;104877;105127.47436262846;11001.22991390611;11260.32438053703;11265.605703800491;11278.492467838967;11434.94282528582;12614.234007238994;12919.966402687762;13409.597712068653;13961.441542338396;13987.580372588838;8691.087435819274;8718.43330183536;8733.868991965126;8802.295816334807;8834.955825220834;8995.28037756978;9001.459912405277;9022.774430639287;9048.55688963976;9136;6623.105880706139;6693.196816382066;6696.397324240842;6699.732010719516;6737.663116844138;1680.8319168083337;1949.7952714965008;1971.6155349706955;2018.777934427212;2020.282799606148;988.1156365053237;988.7577543501889;1035.6323505155713;1088.5972190289644;1122.45560902962;17038.659226815395;20494.282700105425;20719.58560828775;21075.473113171985;21131.894340528506;847.2967437027253;1012.2610494339174;1022.728976821143;1033.26121822897;1079.3254216114929;10703.357798532114;11100.222984391015;11133.832992505118;11135.33188008722;11144.60993865211;607443;615141;617125;625508;644238;64205.678971604844;81692.59153704194;95200;99174.00825991647;104098.47950760198;1086.8261078227604;1088.2219213262556;1105.0938230650788;1105.5964572930823;1110.1063643766845;17576.945383276532;17688;17766.91116544409;18010.72983905269;18184.272629095216;36171.55313787524;41803.58196417997;48081.75959120182;50587.74706126446;50891;65300.34699652943;65413.67293163504;66591.66704166448;71053;75331.62334188294;7263.4915555910575;7883.448158628841;8224.588770561328;8301.294389976678;8425.578721064045;11609.88390116088;12801.93599031999;12891.41988610496;13117.95056395467;13152.079354445097;11074.667759967213;11112.944435277772;11273.436328183394;11604.709882253012;11684.415779210836;10842.891571084503;11180.539612509252;11225.66323010311;11448.912353326421;11556.826647600124;4671.486136525047;7520.736774212876;11157.159068753564;11514.424278786195;11639.709007274885;6997.790066298019;7018.719251229893;8135.9186408135165;8296.958515207627;8426.809587376409;8218.054923683614;10167.542460589439;11307.095432365555;11588.130890183102;11661.416929153678 20:31:44 INFO - PROCESS | 1661 | |3;mootools.html;1477.6527516033736;1620.7115343302073;1639.6146905477208;1921.0874834453637;2032.9898350508245;8335.374846886485;9060;9315.649230861538;9338.25293976482;9348.97161312256;8835;9124.31567632427;9129.634814607407;9130.680426185085;9151.222146117589;2570.049081839722;2593.0924176538156;2595.7144714081437;2597.857117858517;2600.7399260073935;2461.9630705539344;2538.70804857441;2541.3646588352913;2541.6314634378004;2549.222487141421;2552.1067626330823;2574.5751950928075;2598.1685860524544;2604.895804167831;2610.0995156671015;2212.369474699719;2537.8350407223566;2565.589505679092;2565.884535195911;2566.396896729267;2542.0467324753217;2577.072253988563;2581.8579978101197;2583.702874169457;2594.468134032538;8996.460212387277;9205.723828285096;9263.768405789842;9265.490398028105;9289.256859451227;5585.776568937237;5718.942810571883;5740.942590574125;5742.483176514133;5744.080947048494;3706.092007458163;3783.791891445997;3812.8093595320124;3850.0567360996456;3884.4950156479476;1071.7267096890243;1076.321917192164;1081.3511892864296;1100.642291255337;1122.023839259841;12468.43892024861;12647.620571382873;12666.80999785004;12668.68328291791;12669.303188324731;4831.0096430231715;4888.902221955541;4895.926561101586;4917.188663870421;4921.434035085939;9779.413235205768;9821.901780982098;9823.852642210373;9825.164860986753;9850.556724947395;5713.371529131792;5717.971410142923;5729.28383952006;5739.426057394227;5743.2246646703;4683.110209060268;4804.159272127364;5085.771140298695;5262.1317482615705;5307.4427185145005;4038.333674943601;4051.4530538376944;4118.485189351331;4137.54487006429;4178;1271.5422447918743;1277.4698500122345;1282.179405180685;1290.6450726050223;1298.3054066074606;918.9386258871015;928.8420968435382;947.2516711797603;958.9952050239705;981.1071924548627;6021.217241758543;6072.666003369857;6092;6156.507479401726;6180.381961803873;476.2047380873949;480.2939678672346;484.97817598208167;486.90261947610617;489.07564702711903;3476.634953329864;3969.980150099231;4025.6376926076796;4050.7772072535704;4103.466549348565;10880.23838331325;11380.089592832554;11384.373859437645;11392.487338069806;11392.772144557228;11101.722456938642;11238.66284011481;11241.494132764044;11242.044426223863;11455.427228638535;8691.652333906573;8776.34177436682;8780.165884240987;8821.38250322484;8833.514156721314;5659.434056594308;5902.7343769531335;5922.822315330547;5932.851678708067;6045.78839740607;9807.460589667637;9874.654387096418;10101.191904647463;10148.289619726844;10150.340227885164;9930.553125109243;10206.744831379276;10306.639267625596;10366.170706343324;10437.425941573287;7117.395021423237;7337.633118344168;7776.533407995538;7813.531188128731;7959.522428654068;8600.967883853727;8636.481811091355;8663.220310172115;8664.523451209992;8675.045744967922;7540.509866858637;7631.427642926914;7677.8464430709955;7679.2704693054075;7768.456208065381;7502.587357695379;7590.240975902366;7594.962025189839;7716.7684969451;7746.65140068687;7217.7473788417155;7276.818079547842;7279.745208917662;7285.506471173291;7296.270372962661;4927.704337739747;5021.72380519075;5110.9488905110475;5168.819091331786;5180.300659410931;5080.695158290367;5102;5126.7180305083575;5147.356580427447;5224.138017227115 20:31:44 INFO - PROCESS | 1661 | |4;prototype.html;324.440340412788;325.3298205696266;335.9697627213551;339.2401021711366;342.1702371748509;5886.293644762634;6505.934940650592;6623.37077977592;6662.300458451866;6683.866322673556;6487.44856687181;6601.66991650418;6685.364890335422;6686.097376854135;6714.362135597123;3756.455313979471;4299.957000429987;4990.725510096943;4994.97502512487;5017.899642007158;4759.857204283877;4892.77982490787;4895.9755201224125;4987.177115775893;4992.07646585381;4794.9280760788615;4815.374001379816;4819.879503012436;4928.482509336522;4943.382077240345;4157.815022718511;4763.571278584909;4881.658283920127;4929.827456039039;4959.8016079356785;4264.87205383839;4273.935890961607;4277.059047009653;4284.592963668447;4299.763513006784;6456.451201647818;6468.838279043014;6482.6434546099945;6483.254425741053;6495.740170393178;5725.656460612335;5931.970340148272;5934.8813023739285;5938.940610593882;5993.580449368546;5724.427557244284;6184.9176394130845;6833.487488438337;7199.2080871104135;7226.566406015656;4234.745915245065;4602.562756538124;4829.9034019319415;4830.927536086926;4849.4908034656555;7368.042154519878;7468.626568671545;7557.848843023164;7585.393168546559;7604.619769011527;4684.180268453075;4739;4746.406699162605;4746.691465054761;4747.525247475225;4830.589399901048;4833.226683730586;4841.080194762983;4841.298011788342;4847.103285892122;5053.736565858535;5415.377231618336;5734.254546908875;5745.597808153473;5767.134929760569;5976.864395764791;6896.827579310457;7145.606991615511;7196.748113815991;7204.819879503054;1431.6564024634013;1650.092449152961;1679.1855949864307;1734.8872323298945;1747.0827815397017;1048.8793788714243;1086.1419478611965;1087.586717047517;1090.1170052257696;1113.716002419378;6695.363940425652;6757.121574195421;6760.560563563451;6799.286074962058;6815.318468153145;7433.8141546461775;7445.404367650575;7461;7461.365783908429;7468.663910124057;6794.966025169842;6795.558288711218;6796.626185559841;6807.353301436356;6819.488538359643;3846.2692088503095;3919.2945269851703;3952.6837852971694;3962.445257663929;3985.720999530005;6332.8416789579705;7699.153093159748;7760.611969401507;7762.650680719268;7766.262205090507;6604.405603495612;7158.105236845395;7609.048868891388;7619.276168763959;7646.847063058708;6993.2657071007825;7751.844963100706;7760.495567788075;7779.494332868346;7787.92212077872;7179;7411.740589079356;7423.665935032828;7424.888626670712;7438.516496427715;5949;7271.854562908818;7293.0519032525435;7295.781126566211;7303.634818259172;7759.534427934342;7763.689452422066;7774.455788095005;7778.572178530235;7780.766577002699;4959.578435832995;4962.3052772611145;4967.726775027409;4974.403071631427;4974.8756281093265;7105.75129870452;7361.926380736124;7367.336939675455;7371.557706537625;7380.114386273682;7069;7113.181984071898;7119.110111236096;7124.287571243041;7124.786256412316;5694.487496125369;7110.680019399243;7117.537360071578;7124.216336203117;7130.85738285221;6964.512484126062;6970.337817907291;6970.337817907291;6972.023916651774;6975.093237879043;6798.252192258748;6884.862302754017;7107.644617768988;7110.537815042006;7112.679929403086;5636.689982050862;6903.861922761617;6907.171139463297;7089.929100709133;7093.538919970186 20:31:44 INFO - PROCESS | 1661 | |5;yui.html;682.9795106146814;697.7697359871242;704.3238491048593;791.5488171742102;800.0599295827401;15418.92290538547;15668.451604193855;15669.059856408623;15690;15699.686006279868;13695.246761428143;14333.78499322511;14349.354279057441;14362.928185359086;14382.856171438283;845.4039901869168;977.1889331854579;978.3982850546898;978.6134476881628;978.6379039755265;963.3930623707055;977.7751117243039;978.4911845840159;980.1521683743546;981.9410835349867;1037.305005646219;1041.536516250269;1043.7599352149011;1044.6291566493899;1045.1482042135674;1034.0125180452687;1034.1519953637944;1035.9430231337274;1037.642013505347;1038.859753933217;769.7267470048164;771.2865599320662;771.5255118102383;771.5602106799126;773.5397438524069;15829.525114246591;15835.920820395939;15867.92066039674;15870.96838705492;15883.444079457164;12633.873661263453;12727.554535591209;12778.488860445572;12817.102802803807;13123;10424.426656533888;10453.9477302613;11330.206885518017;11639.301641901513;11679.124065695107;3544.6455354464606;3575.0526110580718;3594.802285874276;3620.837062332175;3780.5652349979828;62509.37490625081;79433.60283198605;81562.18437815605;82257.58871205666;82712.17287827104;9560.76098097553;9676.274279429072;9718.416894986323;9885.011498850201;9892.307538472238;22205.22281720132;22218.66671999921;22259.554808903733;22290.442738931655;22292.554148917254;7796.4932279401655;7823.413244006609;7868.488548244346;8077.394195435366;8183.222593853575;3475.1833319169973;4178.582141785797;4236.915261694749;4259.169461954889;4437.445319335083;3760.52993375828;3826.3877779555137;3832.616738326145;3832.9233415332096;3837.13664425502;639.5107742576932;691.920429150644;692.854500554879;694.9722011119499;696.2098018748757;559.7900787204799;600.7236671131241;602.8733965867129;616.6608365399013;636.5671343486381;8069.878951815727;8372;8496.277816385676;8517.446365986316;8595.82808343842;571.2316933724135;579.0821547846626;596.6449962272441;601.0233370772495;606.5087279303779;3338.7996720196866;3924.156306394139;3970.7293666026594;4011.3581826907553;4141.834326626901;84370;85415.86460338542;85624;85787;88283.23433531422;78304.21695783084;79693;79924.60037699774;80674.59662701766;81138.78291825627;67421.98867016999;70686.293137069;71224.64387678029;71796;72529;7738;7917.327027202522;7955.363570914197;8002.07976082758;8155.118051590347;41504.58495415007;49126;50557.49442505675;51163;52041.479585205176;64166.67916660387;64696.70606587936;67055;68736.31263687299;68768.12318768083;9696.272779541421;10116.747081323027;10162.288639795144;10259.538320775433;10563.260571759904;8905.910940890508;10988.780224395627;11003.779924401628;11331.206815522833;11490.965813076864;10405.687829365132;10415.42715150674;10544.89455105439;10762;10904.182186336215;10286.485675716034;10447.216458765472;10471.581136754749;10608.310459820395;10960.890391095987;10202.489875506344;10268.897311026794;10351.327163734333;10926.56293748273;11079.390633514911;8733.825323493622;8842.248408885316;8878;9087.727368178965;9117.726468205965;8992.235659968976;9002.50486223264;9032.412893161923;9087.54562271897;9133.588988495401 20:31:44 INFO - PROCESS | 1661 | __end_tp_report 20:31:44 INFO - PROCESS | 1661 | __start_cc_report 20:31:44 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1138 20:31:44 INFO - PROCESS | 1661 | __end_cc_report 20:31:44 INFO - PROCESS | 1661 | __startTimestamp1468899104584__endTimestamp 20:31:44 INFO - PROCESS | 1661 | 20:31:44 INFO - PROCESS | 1661 | ------- Summary: start ------- 20:31:44 INFO - PROCESS | 1661 | Number of tests: 6 20:31:44 INFO - PROCESS | 1661 | 20:31:44 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5908.29 Median:6217.16 stddev:651.39 (10.5%) stddev-sans-first:625.99 20:31:44 INFO - PROCESS | 1661 | Values: 3525.3 3613.9 3629.3 3637.0 3700.4 5965.0 5991.9 6006.3 6030.8 6037.9 4594.7 5443.6 5983.6 5991.0 5991.0 5289.2 5333.9 5337.4 5361.6 5430.7 5368.7 5425.5 5426.5 5430.3 5431.5 4324.3 5304.2 5345.8 5382.3 5389.4 5426.9 5440.2 5441.8 5466.4 5484.3 5188.0 5238.8 5361.0 5367.4 5373.9 5745.2 5802.6 5805.9 5806.5 5846.0 6371.2 6375.0 6385.9 6390.2 6408.1 6300.6 6317.7 6367.4 6386.0 6386.7 6079.2 6081.2 6087.0 6089.9 6116.1 6413.1 6420.4 6421.1 6423.3 6439.5 6217.2 6228.8 6310.1 6334.6 6389.7 6343.0 6361.7 6364.7 6364.8 6391.8 6331.7 6384.6 6385.3 6399.5 6404.1 6294.5 6317.8 6367.1 6403.4 6407.1 5050.8 5071.0 5078.6 5104.3 5105.1 4539.4 4542.8 4544.2 4546.4 4548.8 5923.6 5951.1 6042.7 6056.2 6083.6 6302.3 6344.0 6344.3 6360.5 6363.7 6027.9 6061.2 6070.1 6077.6 6081.8 5493.8 5562.7 5570.2 5581.5 5606.7 5429.6 6400.6 6469.0 6469.2 6471.7 6323.4 6330.9 6337.3 6342.0 6343.0 6354.3 6477.1 6479.4 6481.4 6488.7 6282.7 6332.5 6375.1 6403.6 6413.5 6328.2 6346.3 6346.9 6348.3 6363.3 6174.8 6200.3 6312.2 6381.5 6406.2 6297.8 6356.6 6376.7 6382.1 6404.4 6194.0 6241.8 6243.9 6249.5 6261.9 6212.0 6213.2 6361.3 6362.4 6378.9 5296.8 6242.1 6249.1 6254.0 6260.7 20:31:44 INFO - PROCESS | 1661 | 20:31:44 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:65839.53 Median:3393.68 stddev:144044.00 (4244.5%) stddev-sans-first:144364.58 20:31:44 INFO - PROCESS | 1661 | Values: 515.1 553.9 560.0 569.1 576.8 33368.7 38559.0 39430.0 39457.8 39469.6 43002.6 43406.0 43428.6 43463.9 43470.9 8987.3 9574.1 9796.9 9809.0 11450.9 11586.3 11722.5 11723.0 11736.2 11741.8 11637.9 11682.5 11687.9 11693.4 11725.4 11556.8 11662.4 11664.1 11677.3 11677.5 11524.6 11637.4 11645.2 11917.4 11930.9 41362.8 41654.2 41659.8 41776.4 42322.4 3277.2 3324.7 3329.5 3388.2 3399.2 27900.9 28411.1 29009.7 29648.6 30222.9 2739.9 2779.1 2824.1 2833.4 2867.6 521571.0 527529.0 527572.0 527903.0 529119.0 37897.6 38432.8 38503.0 64315.7 65143.0 36661.1 36915.0 37004.6 37007.0 37047.6 15895.3 16014.3 16047.8 16082.3 16092.8 12826.9 12829.4 12831.6 12843.4 13878.4 7309.5 8342.3 8374.6 8420.1 8453.5 3430.9 3465.7 3466.3 3472.6 3507.6 1023.5 1042.2 1042.2 1069.6 1139.6 24623.5 29467.4 30867.0 31332.8 31483.8 1071.7 1136.4 1189.7 1205.3 1311.5 15668.9 15685.5 15789.5 15996.4 16054.3 625402.0 626513.0 637497.6 638468.0 639894.8 62369.7 63208.0 63304.0 63320.7 63346.0 1462.6 1500.2 1588.9 1596.1 1651.3 29458.0 29653.3 29871.9 30025.8 30337.7 47089.8 47182.0 47747.8 47876.8 47934.5 436052.0 436839.0 437039.8 437238.0 444813.0 24271.0 27508.6 27983.6 28364.9 28405.4 42923.0 43726.1 44164.6 44967.0 44971.0 35693.6 36336.5 36407.0 36441.0 37119.4 35726.8 35990.3 36118.0 36528.6 38087.8 36826.4 36947.1 37304.3 38281.6 38645.6 32620.7 33391.2 33499.7 33516.3 33580.7 21899.6 24834.3 24983.0 25059.6 25289.4 20:31:44 INFO - PROCESS | 1661 | 20:31:44 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:33782.50 Median:2299.03 stddev:102391.38 (4453.7%) stddev-sans-first:102647.95 20:31:44 INFO - PROCESS | 1661 | Values: 409.9 414.4 415.7 416.3 423.5 15149.5 20287.1 20859.0 20882.5 20910.8 20396.7 20751.5 21050.9 21115.6 21142.2 5805.1 5911.5 6013.5 6016.6 6023.9 5877.8 5971.5 5971.5 5977.3 5978.7 4374.7 5553.8 5566.0 6251.6 6539.9 6426.9 6495.2 6505.7 6517.8 6518.6 5524.5 5635.7 5661.2 5661.7 5666.6 24119.3 24513.5 24834.8 25331.4 25340.7 2271.9 2286.5 2311.6 2327.1 2353.7 12137.6 14822.4 14878.7 15176.3 15222.8 1786.8 1824.3 1848.7 1878.6 1893.2 99001.0 102118.0 103616.5 104877.0 105127.5 11001.2 11260.3 11265.6 11278.5 11434.9 12614.2 12920.0 13409.6 13961.4 13987.6 8691.1 8718.4 8733.9 8802.3 8835.0 8995.3 9001.5 9022.8 9048.6 9136.0 6623.1 6693.2 6696.4 6699.7 6737.7 1680.8 1949.8 1971.6 2018.8 2020.3 988.1 988.8 1035.6 1088.6 1122.5 17038.7 20494.3 20719.6 21075.5 21131.9 847.3 1012.3 1022.7 1033.3 1079.3 10703.4 11100.2 11133.8 11135.3 11144.6 607443.0 615141.0 617125.0 625508.0 644238.0 64205.7 81692.6 95200.0 99174.0 104098.5 1086.8 1088.2 1105.1 1105.6 1110.1 17576.9 17688.0 17766.9 18010.7 18184.3 36171.6 41803.6 48081.8 50587.7 50891.0 65300.3 65413.7 66591.7 71053.0 75331.6 7263.5 7883.4 8224.6 8301.3 8425.6 11609.9 12801.9 12891.4 13118.0 13152.1 11074.7 11112.9 11273.4 11604.7 11684.4 10842.9 11180.5 11225.7 11448.9 11556.8 4671.5 7520.7 11157.2 11514.4 11639.7 6997.8 7018.7 8135.9 8297.0 8426.8 8218.1 10167.5 11307.1 11588.1 11661.4 20:31:44 INFO - PROCESS | 1661 | 20:31:44 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5942.30 Median:5051.21 stddev:3337.46 (66.1%) stddev-sans-first:3329.96 20:31:44 INFO - PROCESS | 1661 | Values: 1477.7 1620.7 1639.6 1921.1 2033.0 8335.4 9060.0 9315.6 9338.3 9349.0 8835.0 9124.3 9129.6 9130.7 9151.2 2570.0 2593.1 2595.7 2597.9 2600.7 2462.0 2538.7 2541.4 2541.6 2549.2 2552.1 2574.6 2598.2 2604.9 2610.1 2212.4 2537.8 2565.6 2565.9 2566.4 2542.0 2577.1 2581.9 2583.7 2594.5 8996.5 9205.7 9263.8 9265.5 9289.3 5585.8 5718.9 5740.9 5742.5 5744.1 3706.1 3783.8 3812.8 3850.1 3884.5 1071.7 1076.3 1081.4 1100.6 1122.0 12468.4 12647.6 12666.8 12668.7 12669.3 4831.0 4888.9 4895.9 4917.2 4921.4 9779.4 9821.9 9823.9 9825.2 9850.6 5713.4 5718.0 5729.3 5739.4 5743.2 4683.1 4804.2 5085.8 5262.1 5307.4 4038.3 4051.5 4118.5 4137.5 4178.0 1271.5 1277.5 1282.2 1290.6 1298.3 918.9 928.8 947.3 959.0 981.1 6021.2 6072.7 6092.0 6156.5 6180.4 476.2 480.3 485.0 486.9 489.1 3476.6 3970.0 4025.6 4050.8 4103.5 10880.2 11380.1 11384.4 11392.5 11392.8 11101.7 11238.7 11241.5 11242.0 11455.4 8691.7 8776.3 8780.2 8821.4 8833.5 5659.4 5902.7 5922.8 5932.9 6045.8 9807.5 9874.7 10101.2 10148.3 10150.3 9930.6 10206.7 10306.6 10366.2 10437.4 7117.4 7337.6 7776.5 7813.5 7959.5 8601.0 8636.5 8663.2 8664.5 8675.0 7540.5 7631.4 7677.8 7679.3 7768.5 7502.6 7590.2 7595.0 7716.8 7746.7 7217.7 7276.8 7279.7 7285.5 7296.3 4927.7 5021.7 5110.9 5168.8 5180.3 5080.7 5102.0 5126.7 5147.4 5224.1 20:31:44 INFO - PROCESS | 1661 | 20:31:44 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5812.07 Median:6603.04 stddev:1848.43 (28.0%) stddev-sans-first:1807.14 20:31:44 INFO - PROCESS | 1661 | Values: 324.4 325.3 336.0 339.2 342.2 5886.3 6505.9 6623.4 6662.3 6683.9 6487.4 6601.7 6685.4 6686.1 6714.4 3756.5 4300.0 4990.7 4995.0 5017.9 4759.9 4892.8 4896.0 4987.2 4992.1 4794.9 4815.4 4819.9 4928.5 4943.4 4157.8 4763.6 4881.7 4929.8 4959.8 4264.9 4273.9 4277.1 4284.6 4299.8 6456.5 6468.8 6482.6 6483.3 6495.7 5725.7 5932.0 5934.9 5938.9 5993.6 5724.4 6184.9 6833.5 7199.2 7226.6 4234.7 4602.6 4829.9 4830.9 4849.5 7368.0 7468.6 7557.8 7585.4 7604.6 4684.2 4739.0 4746.4 4746.7 4747.5 4830.6 4833.2 4841.1 4841.3 4847.1 5053.7 5415.4 5734.3 5745.6 5767.1 5976.9 6896.8 7145.6 7196.7 7204.8 1431.7 1650.1 1679.2 1734.9 1747.1 1048.9 1086.1 1087.6 1090.1 1113.7 6695.4 6757.1 6760.6 6799.3 6815.3 7433.8 7445.4 7461.0 7461.4 7468.7 6795.0 6795.6 6796.6 6807.4 6819.5 3846.3 3919.3 3952.7 3962.4 3985.7 6332.8 7699.2 7760.6 7762.7 7766.3 6604.4 7158.1 7609.0 7619.3 7646.8 6993.3 7751.8 7760.5 7779.5 7787.9 7179.0 7411.7 7423.7 7424.9 7438.5 5949.0 7271.9 7293.1 7295.8 7303.6 7759.5 7763.7 7774.5 7778.6 7780.8 4959.6 4962.3 4967.7 4974.4 4974.9 7105.8 7361.9 7367.3 7371.6 7380.1 7069.0 7113.2 7119.1 7124.3 7124.8 5694.5 7110.7 7117.5 7124.2 7130.9 6964.5 6970.3 6970.3 6972.0 6975.1 6798.3 6884.9 7107.6 7110.5 7112.7 5636.7 6903.9 6907.2 7089.9 7093.5 20:31:44 INFO - PROCESS | 1661 | 20:31:44 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:18033.84 Median:587.86 stddev:25112.58 (4271.8%) stddev-sans-first:25149.23 20:31:44 INFO - PROCESS | 1661 | Values: 683.0 697.8 704.3 791.5 800.1 15418.9 15668.5 15669.1 15690.0 15699.7 13695.2 14333.8 14349.4 14362.9 14382.9 845.4 977.2 978.4 978.6 978.6 963.4 977.8 978.5 980.2 981.9 1037.3 1041.5 1043.8 1044.6 1045.1 1034.0 1034.2 1035.9 1037.6 1038.9 769.7 771.3 771.5 771.6 773.5 15829.5 15835.9 15867.9 15871.0 15883.4 12633.9 12727.6 12778.5 12817.1 13123.0 10424.4 10453.9 11330.2 11639.3 11679.1 3544.6 3575.1 3594.8 3620.8 3780.6 62509.4 79433.6 81562.2 82257.6 82712.2 9560.8 9676.3 9718.4 9885.0 9892.3 22205.2 22218.7 22259.6 22290.4 22292.6 7796.5 7823.4 7868.5 8077.4 8183.2 3475.2 4178.6 4236.9 4259.2 4437.4 3760.5 3826.4 3832.6 3832.9 3837.1 639.5 691.9 692.9 695.0 696.2 559.8 600.7 602.9 616.7 636.6 8069.9 8372.0 8496.3 8517.4 8595.8 571.2 579.1 596.6 601.0 606.5 3338.8 3924.2 3970.7 4011.4 4141.8 84370.0 85415.9 85624.0 85787.0 88283.2 78304.2 79693.0 79924.6 80674.6 81138.8 67422.0 70686.3 71224.6 71796.0 72529.0 7738.0 7917.3 7955.4 8002.1 8155.1 41504.6 49126.0 50557.5 51163.0 52041.5 64166.7 64696.7 67055.0 68736.3 68768.1 9696.3 10116.7 10162.3 10259.5 10563.3 8905.9 10988.8 11003.8 11331.2 11491.0 10405.7 10415.4 10544.9 10762.0 10904.2 10286.5 10447.2 10471.6 10608.3 10960.9 10202.5 10268.9 10351.3 10926.6 11079.4 8733.8 8842.2 8878.0 9087.7 9117.7 8992.2 9002.5 9032.4 9087.5 9133.6 20:31:44 INFO - PROCESS | 1661 | -------- Summary: end -------- 20:31:44 INFO - PROCESS | 1661 | 20:31:45 INFO - TEST-INFO | 1661: exit 0 20:31:45 INFO - TEST-OK | dromaeo_css | took 1112910ms 20:31:45 INFO - TEST-START | kraken 20:31:45 INFO - operating with platform_type : mac_ 20:31:45 INFO - Initialising browser for kraken test... 20:31:45 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpxkw0sn/profile http://localhost:49264/getInfo.html) 20:31:47 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 20:31:47 INFO - PROCESS | 1672 | colorDepth:24 20:31:47 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 20:31:47 INFO - PROCESS | 1672 | __metrics 20:31:47 INFO - PROCESS | 1672 | 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" 20:31:47 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:31:47 INFO - TEST-INFO | 1672: exit 0 20:31:47 INFO - Browser initialized. 20:31:47 INFO - Running cycle 1/1 for kraken test... 20:31:47 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpxkw0sn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:31:59 INFO - PROCESS | 1675 | RSS: Main: 160411648 20:31:59 INFO - PROCESS | 1675 | 20:32:02 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 20:32:03 INFO - PROCESS | 1675 | RSS: Main: 223866880 20:32:03 INFO - PROCESS | 1675 | 20:32:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 20:32:06 INFO - PROCESS | 1675 | RSS: Main: 239472640 20:32:06 INFO - PROCESS | 1675 | 20:32:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 20:32:10 INFO - PROCESS | 1675 | RSS: Main: 324079616 20:32:10 INFO - PROCESS | 1675 | 20:32:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 20:32:13 INFO - PROCESS | 1675 | RSS: Main: 232448000 20:32:13 INFO - PROCESS | 1675 | 20:32:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:32:15 INFO - PROCESS | 1675 | RSS: Main: 232251392 20:32:15 INFO - PROCESS | 1675 | 20:32:18 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 20:32:19 INFO - PROCESS | 1675 | RSS: Main: 268644352 20:32:19 INFO - PROCESS | 1675 | 20:32:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 20:32:22 INFO - PROCESS | 1675 | RSS: Main: 270249984 20:32:22 INFO - PROCESS | 1675 | 20:32:25 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 20:32:25 INFO - PROCESS | 1675 | RSS: Main: 267292672 20:32:25 INFO - PROCESS | 1675 | 20:32:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:32:28 INFO - PROCESS | 1675 | RSS: Main: 260640768 20:32:28 INFO - PROCESS | 1675 | 20:32:29 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:32:30 INFO - PROCESS | 1675 | RSS: Main: 266862592 20:32:30 INFO - PROCESS | 1675 | 20:32:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:32:33 INFO - PROCESS | 1675 | RSS: Main: 270921728 20:32:33 INFO - PROCESS | 1675 | 20:32:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:32:36 INFO - PROCESS | 1675 | RSS: Main: 278368256 20:32:36 INFO - PROCESS | 1675 | 20:32:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:32:40 INFO - PROCESS | 1675 | RSS: Main: 275415040 20:32:40 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 20:32:42 INFO - PROCESS | 1675 | RSS: Main: 336441344 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | __start_tp_report 20:32:42 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 20:32:42 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 20:32:42 INFO - PROCESS | 1675 | |i|pagename|runs| 20:32:42 INFO - PROCESS | 1675 | |0;ai-astar;111;112;119;113;111;110;111;112;112;136 20:32:42 INFO - PROCESS | 1675 | |1;audio-beat-detection;157;120;142;199;146;174;139;119;181;117 20:32:42 INFO - PROCESS | 1675 | |2;audio-dft;185;187;184;185;185;184;185;185;189;223 20:32:42 INFO - PROCESS | 1675 | |3;audio-fft;69;81;94;187;84;55;56;57;131;55 20:32:42 INFO - PROCESS | 1675 | |4;audio-oscillator;93;95;147;80;78;90;126;79;78;126 20:32:42 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;87;84;88;85;87;83;88;84;87;85 20:32:42 INFO - PROCESS | 1675 | |6;imaging-darkroom;92;92;115;124;92;92;93;92;93;91 20:32:42 INFO - PROCESS | 1675 | |7;imaging-desaturate;85;86;86;83;85;82;87;84;84;83 20:32:42 INFO - PROCESS | 1675 | |8;json-parse-financial;59;62;62;62;63;63;62;83;59;56 20:32:42 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;63;62;68;66;76;71;68;66;65;66 20:32:42 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;94;92;100;103;78;80;79;77;79;84 20:32:42 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;127;124;125;138;130;147;139;130;166;161 20:32:42 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;162;157;159;166;166;174;163;208;209;162 20:32:42 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;66;68;66;69;67;66;66;65;68;68 20:32:42 INFO - PROCESS | 1675 | __end_tp_report 20:32:42 INFO - PROCESS | 1675 | __start_cc_report 20:32:42 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1894 20:32:42 INFO - PROCESS | 1675 | __end_cc_report 20:32:42 INFO - PROCESS | 1675 | __startTimestamp1468899162349__endTimestamp 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | ------- Summary: start ------- 20:32:42 INFO - PROCESS | 1675 | Number of tests: 14 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:114.70 Median:112.00 stddev:7.89 (7.0%) stddev-sans-first:8.25 20:32:42 INFO - PROCESS | 1675 | Values: 111.0 112.0 119.0 113.0 111.0 110.0 111.0 112.0 112.0 136.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:151.50 stddev:28.16 (18.6%) stddev-sans-first:29.73 20:32:42 INFO - PROCESS | 1675 | Values: 157.0 120.0 142.0 199.0 146.0 174.0 139.0 119.0 181.0 117.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:189.20 Median:185.00 stddev:11.97 (6.5%) stddev-sans-first:12.60 20:32:42 INFO - PROCESS | 1675 | Values: 185.0 187.0 184.0 185.0 185.0 184.0 185.0 185.0 189.0 223.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:86.90 Median:63.00 stddev:42.51 (67.5%) stddev-sans-first:44.59 20:32:42 INFO - PROCESS | 1675 | Values: 69.0 81.0 94.0 187.0 84.0 55.0 56.0 57.0 131.0 55.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:99.20 Median:79.50 stddev:24.81 (31.2%) stddev-sans-first:26.21 20:32:42 INFO - PROCESS | 1675 | Values: 93.0 95.0 147.0 80.0 78.0 90.0 126.0 79.0 78.0 126.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.81 (2.1%) stddev-sans-first:1.87 20:32:42 INFO - PROCESS | 1675 | Values: 87.0 84.0 88.0 85.0 87.0 83.0 88.0 84.0 87.0 85.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:92.00 stddev:11.75 (12.8%) stddev-sans-first:12.29 20:32:42 INFO - PROCESS | 1675 | Values: 92.0 92.0 115.0 124.0 92.0 92.0 93.0 92.0 93.0 91.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:1.58 (1.9%) stddev-sans-first:1.67 20:32:42 INFO - PROCESS | 1675 | Values: 85.0 86.0 86.0 83.0 85.0 82.0 87.0 84.0 84.0 83.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:62.00 stddev:7.34 (11.8%) stddev-sans-first:7.63 20:32:42 INFO - PROCESS | 1675 | Values: 59.0 62.0 62.0 62.0 63.0 63.0 62.0 83.0 59.0 56.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:4.04 (6.0%) stddev-sans-first:4.00 20:32:42 INFO - PROCESS | 1675 | Values: 63.0 62.0 68.0 66.0 76.0 71.0 68.0 66.0 65.0 66.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:79.50 stddev:9.80 (12.3%) stddev-sans-first:10.02 20:32:42 INFO - PROCESS | 1675 | Values: 94.0 92.0 100.0 103.0 78.0 80.0 79.0 77.0 79.0 84.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:138.50 stddev:14.92 (10.8%) stddev-sans-first:15.22 20:32:42 INFO - PROCESS | 1675 | Values: 127.0 124.0 125.0 138.0 130.0 147.0 139.0 130.0 166.0 161.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:166.00 stddev:19.47 (11.7%) stddev-sans-first:20.27 20:32:42 INFO - PROCESS | 1675 | Values: 162.0 157.0 159.0 166.0 166.0 174.0 163.0 208.0 209.0 162.0 20:32:42 INFO - PROCESS | 1675 | 20:32:42 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.29 (1.9%) stddev-sans-first:1.32 20:32:42 INFO - PROCESS | 1675 | Values: 66.0 68.0 66.0 69.0 67.0 66.0 66.0 65.0 68.0 68.0 20:32:42 INFO - PROCESS | 1675 | -------- Summary: end -------- 20:32:42 INFO - PROCESS | 1675 | 20:32:43 INFO - TEST-INFO | 1675: exit 0 20:32:43 INFO - TEST-OK | kraken | took 57905ms 20:32:43 INFO - SUITE-END | took 1170s 20:32:43 INFO - Completed test suite (00:19:31) 20:32:43 INFO - javascript benchmark 20:32:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3525.2596954639525, 3613.8554457821688, 3629.256002519483, 3637.0, 3700.4449332600107, 5965.045592705168, 5991.910121348178, 6006.346553662198, 6030.849228769277, 6037.909431358533, 4594.72431654101, 5443.564514838813, 5983.58114931955, 5990.970045149779, 5991.0, 5289.18017707256, 5333.946660533384, 5337.386200586943, 5361.571074314045, 5430.728463576806, 5368.651037682557, 5425.484578964992, 5426.538744206747, 5430.321209848769, 5431.511163995239, 4324.286492728712, 5304.151335786275, 5345.786168553253, 5382.327209098863, 5389.407165211824, 5426.9185962210595, 5440.183972404131, 5441.755121019563, 5466.371367292732, 5484.314460692413, 5187.974060129713, 5238.816641417532, 5361.008213480519, 5367.355917289911, 5373.892522149535, 5745.195672605839, 5802.564807639444, 5805.941940580582, 5806.506446951972, 5846.035404158309, 6371.23545174582, 6375.043743438475, 6385.904211436786, 6390.233172019387, 6408.134901788246, 6300.590461620026, 6317.715702793339, 6367.426931576134, 6385.968070159666, 6386.744530218785, 6079.179310792986, 6081.158581894102, 6086.969565152146, 6089.908651370233, 6116.1437398763765, 6413.070104834773, 6420.390062944013, 6421.068945002949, 6423.293437721847, 6439.54923155384, 6217.160683307786, 6228.813135605939, 6310.1481300024825, 6334.588251763713, 6389.6805159741825, 6342.968285158545, 6361.713722882481, 6364.745410183541, 6364.840878978062, 6391.776287829904, 6331.746730130835, 6384.6169229846355, 6385.29761726219, 6399.488040956712, 6404.135441715309, 6294.496440284766, 6317.778877739257, 6367.076773867763, 6403.359664033653, 6407.13503677007, 5050.823221187241, 5070.974645126751, 5078.619103567247, 5104.285400043997, 5105.132127538327, 4539.387182730356, 4542.818287268472, 4544.227481328182, 4546.40896683429, 4548.7725613719185, 5923.614965027259, 5951.077582974646, 6042.728077236535, 6056.152138700585, 6083.6045657032155, 6302.306746257908, 6344.048392741126, 6344.270408903035, 6360.491160707133, 6363.681815909186, 6027.939720602738, 6061.151438798572, 6070.119832624245, 6077.604955677867, 6081.7871374502565, 5493.7802487900035, 5562.721863906789, 5570.220169176318, 5581.469760372758, 5606.719664016864, 5429.592780541475, 6400.583962042452, 6469.029645553111, 6469.159009328757, 6471.676416179078, 6323.367663233824, 6330.936690633035, 6337.334579869047, 6341.985282354801, 6343.016832390987, 6354.301026886947, 6477.125588045554, 6479.352064793483, 6481.449076828522, 6488.740450381932, 6282.685865706788, 6332.461740752087, 6375.075614036032, 6403.551751377358, 6413.518986076157, 6328.240611126695, 6346.270178929482, 6346.873062538631, 6348.269948955744, 6363.300036996019, 6174.8147555573405, 6200.3489633589625, 6312.154765053095, 6381.457576106083, 6406.167198264196, 6297.779577714758, 6356.618602883842, 6376.713047912763, 6382.074599183, 6404.391582799627, 6194.0, 6241.843953901189, 6243.875122497434, 6249.468795152463, 6261.906071408841, 6211.9689401552705, 6213.161223234805, 6361.332060133619, 6362.395572420613, 6378.872422551616, 5296.781740199853, 6242.126102345766, 6249.0626406039455, 6254.0, 6260.718267677874], "value": 5868.93348552091, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.0805811626248, 553.9362973258075, 559.9696558332668, 569.0922977850328, 576.780823287151, 33368.66631333689, 38559.0, 39430.0, 39457.802710986405, 39469.605303946955, 43002.56997430025, 43406.0, 43428.56571434285, 43463.91340216496, 43470.91322716934, 8987.281017518582, 9574.138327550536, 9796.902030979705, 9808.950955245215, 11450.885491145065, 11586.304821710683, 11722.472488737985, 11723.0, 11736.237144585617, 11741.823872641917, 11637.883621163806, 11682.474288656987, 11687.883121168807, 11693.356865372401, 11725.413729313543, 11556.82664760025, 11662.358570278631, 11664.125190610737, 11677.299362038262, 11677.532898684043, 11524.59663911759, 11637.418129093512, 11645.243059201124, 11917.404129793562, 11930.940345298304, 41362.79318603418, 41654.1669166618, 41659.791701041606, 41776.37335439971, 42322.365164522555, 3277.2134687675025, 3324.6675332466803, 3329.4886962720143, 3388.1868351595685, 3399.1672040350027, 27900.860495697594, 28411.147665570064, 29009.709902901122, 29648.555271670943, 30222.942197023218, 2739.917802465929, 2779.069011881022, 2824.138637715496, 2833.39082097348, 2867.627208462907, 521571.0, 527529.0, 527572.0, 527903.0, 529119.0, 37897.62102378941, 38432.8078359612, 38503.0, 64315.67842160853, 65143.0, 36661.083472912855, 36915.0, 37004.629953700656, 37007.0, 37047.629523704956, 15895.284712187979, 16014.279357428944, 16047.839521604868, 16082.276297566637, 16092.839071609369, 12826.9358653208, 12829.422675979604, 12831.615051548468, 12843.422046007765, 13878.375473103735, 7309.5248808827255, 8342.332613390914, 8374.623141958504, 8420.073791883011, 8453.49279043247, 3430.8970730878113, 3465.70541503975, 3466.3240668069484, 3472.618012018676, 3507.5790905091044, 1023.4933707814531, 1042.166266986423, 1042.2339580408393, 1069.5989004123453, 1139.5783560082657, 24623.50752984966, 29467.410651786846, 30867.0, 31332.843335783175, 31483.84258078695, 1071.7159952612565, 1136.420425582942, 1189.6609466302236, 1205.2768338996532, 1311.4557458654742, 15668.903176777743, 15685.529434116996, 15789.526314210363, 15996.360145594279, 16054.27755750994, 625402.0, 626513.0, 637497.6250237438, 638468.0, 639894.8005259944, 62369.68815155986, 63208.0, 63304.0, 63320.683396582725, 63346.0, 1462.6050966239056, 1500.2273828978084, 1588.9126098064487, 1596.074276919407, 1651.347717651521, 29458.0, 29653.25866853346, 29871.850640746656, 30025.849870750506, 30337.696623033487, 47089.764551177024, 47182.0, 47747.761261193475, 47876.7606161967, 47934.52065479301, 436052.0, 436839.0, 437039.814800924, 437238.0, 444813.0, 24271.029158833448, 27508.58737118985, 27983.58024629673, 28364.85817570899, 28405.43189136247, 42923.0, 43726.12547749091, 44164.55835441733, 44967.0, 44971.0, 35693.64306357007, 36336.4549531752, 36407.0, 36441.0, 37119.44320835135, 35726.821365893, 35990.28019439649, 36118.0, 36528.634713653584, 38087.80956095202, 36826.447603286506, 36947.07632309106, 37304.25391492209, 38281.6171838278, 38645.6135438642, 32620.673793261765, 33391.165220869676, 33499.665003349655, 33516.329673406886, 33580.664193357756, 21899.562008760055, 24834.25497235086, 24983.0, 25059.62172080553, 25289.367765806], "value": 19065.157967558138, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.94875640544933, 414.446713637294, 415.65085328324204, 416.25698128840025, 423.5087298733468, 15149.545513634608, 20287.08708108135, 20858.95705214739, 20882.477938051536, 20910.790892091114, 20396.694049589267, 20751.481212969684, 21050.89474552629, 21115.57768844622, 21142.15431382743, 5805.071188609823, 5911.497522710564, 6013.458788709016, 6016.608920420181, 6023.879522409571, 5877.794277200299, 5971.4625683688455, 5971.522278217754, 5977.282726072855, 5978.730957106941, 4374.671899607526, 5553.750081246354, 5566.0, 6251.593646412991, 6539.934600654004, 6426.871462570769, 6495.220573531183, 6505.674716264168, 6517.804465866008, 6518.576292540994, 5524.475174858382, 5635.6618602883955, 5661.235733176051, 5661.745221465044, 5666.631668941505, 24119.2764217072, 24513.509729805304, 24834.758262086823, 25331.366715832068, 25340.746592534022, 2271.943201419961, 2286.45125169958, 2311.6070268054305, 2327.0691723310642, 2353.705786776653, 12137.575184868487, 14822.40710371584, 14878.70242595153, 15176.317065732068, 15222.771658425132, 1786.7855857297207, 1824.2520566567775, 1848.7134494153427, 1878.5679293762375, 1893.1764682363216, 99001.0, 102118.0, 103616.48191759069, 104877.0, 105127.47436262846, 11001.22991390611, 11260.32438053703, 11265.605703800491, 11278.492467838967, 11434.94282528582, 12614.234007238994, 12919.966402687762, 13409.597712068653, 13961.441542338396, 13987.580372588838, 8691.087435819274, 8718.43330183536, 8733.868991965126, 8802.295816334807, 8834.955825220834, 8995.28037756978, 9001.459912405277, 9022.774430639287, 9048.55688963976, 9136.0, 6623.105880706139, 6693.196816382066, 6696.397324240842, 6699.732010719516, 6737.663116844138, 1680.8319168083337, 1949.7952714965008, 1971.6155349706955, 2018.777934427212, 2020.282799606148, 988.1156365053237, 988.7577543501889, 1035.6323505155713, 1088.5972190289644, 1122.45560902962, 17038.659226815395, 20494.282700105425, 20719.58560828775, 21075.473113171985, 21131.894340528506, 847.2967437027253, 1012.2610494339174, 1022.728976821143, 1033.26121822897, 1079.3254216114929, 10703.357798532114, 11100.222984391015, 11133.832992505118, 11135.33188008722, 11144.60993865211, 607443.0, 615141.0, 617125.0, 625508.0, 644238.0, 64205.678971604844, 81692.59153704194, 95200.0, 99174.00825991647, 104098.47950760198, 1086.8261078227604, 1088.2219213262556, 1105.0938230650788, 1105.5964572930823, 1110.1063643766845, 17576.945383276532, 17688.0, 17766.91116544409, 18010.72983905269, 18184.272629095216, 36171.55313787524, 41803.58196417997, 48081.75959120182, 50587.74706126446, 50891.0, 65300.34699652943, 65413.67293163504, 66591.66704166448, 71053.0, 75331.62334188294, 7263.4915555910575, 7883.448158628841, 8224.588770561328, 8301.294389976678, 8425.578721064045, 11609.88390116088, 12801.93599031999, 12891.41988610496, 13117.95056395467, 13152.079354445097, 11074.667759967213, 11112.944435277772, 11273.436328183394, 11604.709882253012, 11684.415779210836, 10842.891571084503, 11180.539612509252, 11225.66323010311, 11448.912353326421, 11556.826647600124, 4671.486136525047, 7520.736774212876, 11157.159068753564, 11514.424278786195, 11639.709007274885, 6997.790066298019, 7018.719251229893, 8135.9186408135165, 8296.958515207627, 8426.809587376409, 8218.054923683614, 10167.542460589439, 11307.095432365555, 11588.130890183102, 11661.416929153678], "value": 9609.358328464334, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.6527516033736, 1620.7115343302073, 1639.6146905477208, 1921.0874834453637, 2032.9898350508245, 8335.374846886485, 9060.0, 9315.649230861538, 9338.25293976482, 9348.97161312256, 8835.0, 9124.31567632427, 9129.634814607407, 9130.680426185085, 9151.222146117589, 2570.049081839722, 2593.0924176538156, 2595.7144714081437, 2597.857117858517, 2600.7399260073935, 2461.9630705539344, 2538.70804857441, 2541.3646588352913, 2541.6314634378004, 2549.222487141421, 2552.1067626330823, 2574.5751950928075, 2598.1685860524544, 2604.895804167831, 2610.0995156671015, 2212.369474699719, 2537.8350407223566, 2565.589505679092, 2565.884535195911, 2566.396896729267, 2542.0467324753217, 2577.072253988563, 2581.8579978101197, 2583.702874169457, 2594.468134032538, 8996.460212387277, 9205.723828285096, 9263.768405789842, 9265.490398028105, 9289.256859451227, 5585.776568937237, 5718.942810571883, 5740.942590574125, 5742.483176514133, 5744.080947048494, 3706.092007458163, 3783.791891445997, 3812.8093595320124, 3850.0567360996456, 3884.4950156479476, 1071.7267096890243, 1076.321917192164, 1081.3511892864296, 1100.642291255337, 1122.023839259841, 12468.43892024861, 12647.620571382873, 12666.80999785004, 12668.68328291791, 12669.303188324731, 4831.0096430231715, 4888.902221955541, 4895.926561101586, 4917.188663870421, 4921.434035085939, 9779.413235205768, 9821.901780982098, 9823.852642210373, 9825.164860986753, 9850.556724947395, 5713.371529131792, 5717.971410142923, 5729.28383952006, 5739.426057394227, 5743.2246646703, 4683.110209060268, 4804.159272127364, 5085.771140298695, 5262.1317482615705, 5307.4427185145005, 4038.333674943601, 4051.4530538376944, 4118.485189351331, 4137.54487006429, 4178.0, 1271.5422447918743, 1277.4698500122345, 1282.179405180685, 1290.6450726050223, 1298.3054066074606, 918.9386258871015, 928.8420968435382, 947.2516711797603, 958.9952050239705, 981.1071924548627, 6021.217241758543, 6072.666003369857, 6092.0, 6156.507479401726, 6180.381961803873, 476.2047380873949, 480.2939678672346, 484.97817598208167, 486.90261947610617, 489.07564702711903, 3476.634953329864, 3969.980150099231, 4025.6376926076796, 4050.7772072535704, 4103.466549348565, 10880.23838331325, 11380.089592832554, 11384.373859437645, 11392.487338069806, 11392.772144557228, 11101.722456938642, 11238.66284011481, 11241.494132764044, 11242.044426223863, 11455.427228638535, 8691.652333906573, 8776.34177436682, 8780.165884240987, 8821.38250322484, 8833.514156721314, 5659.434056594308, 5902.7343769531335, 5922.822315330547, 5932.851678708067, 6045.78839740607, 9807.460589667637, 9874.654387096418, 10101.191904647463, 10148.289619726844, 10150.340227885164, 9930.553125109243, 10206.744831379276, 10306.639267625596, 10366.170706343324, 10437.425941573287, 7117.395021423237, 7337.633118344168, 7776.533407995538, 7813.531188128731, 7959.522428654068, 8600.967883853727, 8636.481811091355, 8663.220310172115, 8664.523451209992, 8675.045744967922, 7540.509866858637, 7631.427642926914, 7677.8464430709955, 7679.2704693054075, 7768.456208065381, 7502.587357695379, 7590.240975902366, 7594.962025189839, 7716.7684969451, 7746.65140068687, 7217.7473788417155, 7276.818079547842, 7279.745208917662, 7285.506471173291, 7296.270372962661, 4927.704337739747, 5021.72380519075, 5110.9488905110475, 5168.819091331786, 5180.300659410931, 5080.695158290367, 5102.0, 5126.7180305083575, 5147.356580427447, 5224.138017227115], "value": 4709.944160158369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.440340412788, 325.3298205696266, 335.9697627213551, 339.2401021711366, 342.1702371748509, 5886.293644762634, 6505.934940650592, 6623.37077977592, 6662.300458451866, 6683.866322673556, 6487.44856687181, 6601.66991650418, 6685.364890335422, 6686.097376854135, 6714.362135597123, 3756.455313979471, 4299.957000429987, 4990.725510096943, 4994.97502512487, 5017.899642007158, 4759.857204283877, 4892.77982490787, 4895.9755201224125, 4987.177115775893, 4992.07646585381, 4794.9280760788615, 4815.374001379816, 4819.879503012436, 4928.482509336522, 4943.382077240345, 4157.815022718511, 4763.571278584909, 4881.658283920127, 4929.827456039039, 4959.8016079356785, 4264.87205383839, 4273.935890961607, 4277.059047009653, 4284.592963668447, 4299.763513006784, 6456.451201647818, 6468.838279043014, 6482.6434546099945, 6483.254425741053, 6495.740170393178, 5725.656460612335, 5931.970340148272, 5934.8813023739285, 5938.940610593882, 5993.580449368546, 5724.427557244284, 6184.9176394130845, 6833.487488438337, 7199.2080871104135, 7226.566406015656, 4234.745915245065, 4602.562756538124, 4829.9034019319415, 4830.927536086926, 4849.4908034656555, 7368.042154519878, 7468.626568671545, 7557.848843023164, 7585.393168546559, 7604.619769011527, 4684.180268453075, 4739.0, 4746.406699162605, 4746.691465054761, 4747.525247475225, 4830.589399901048, 4833.226683730586, 4841.080194762983, 4841.298011788342, 4847.103285892122, 5053.736565858535, 5415.377231618336, 5734.254546908875, 5745.597808153473, 5767.134929760569, 5976.864395764791, 6896.827579310457, 7145.606991615511, 7196.748113815991, 7204.819879503054, 1431.6564024634013, 1650.092449152961, 1679.1855949864307, 1734.8872323298945, 1747.0827815397017, 1048.8793788714243, 1086.1419478611965, 1087.586717047517, 1090.1170052257696, 1113.716002419378, 6695.363940425652, 6757.121574195421, 6760.560563563451, 6799.286074962058, 6815.318468153145, 7433.8141546461775, 7445.404367650575, 7461.0, 7461.365783908429, 7468.663910124057, 6794.966025169842, 6795.558288711218, 6796.626185559841, 6807.353301436356, 6819.488538359643, 3846.2692088503095, 3919.2945269851703, 3952.6837852971694, 3962.445257663929, 3985.720999530005, 6332.8416789579705, 7699.153093159748, 7760.611969401507, 7762.650680719268, 7766.262205090507, 6604.405603495612, 7158.105236845395, 7609.048868891388, 7619.276168763959, 7646.847063058708, 6993.2657071007825, 7751.844963100706, 7760.495567788075, 7779.494332868346, 7787.92212077872, 7179.0, 7411.740589079356, 7423.665935032828, 7424.888626670712, 7438.516496427715, 5949.0, 7271.854562908818, 7293.0519032525435, 7295.781126566211, 7303.634818259172, 7759.534427934342, 7763.689452422066, 7774.455788095005, 7778.572178530235, 7780.766577002699, 4959.578435832995, 4962.3052772611145, 4967.726775027409, 4974.403071631427, 4974.8756281093265, 7105.75129870452, 7361.926380736124, 7367.336939675455, 7371.557706537625, 7380.114386273682, 7069.0, 7113.181984071898, 7119.110111236096, 7124.287571243041, 7124.786256412316, 5694.487496125369, 7110.680019399243, 7117.537360071578, 7124.216336203117, 7130.85738285221, 6964.512484126062, 6970.337817907291, 6970.337817907291, 6972.023916651774, 6975.093237879043, 6798.252192258748, 6884.862302754017, 7107.644617768988, 7110.537815042006, 7112.679929403086, 5636.689982050862, 6903.861922761617, 6907.171139463297, 7089.929100709133, 7093.538919970186], "value": 5197.096268927371, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.9795106146814, 697.7697359871242, 704.3238491048593, 791.5488171742102, 800.0599295827401, 15418.92290538547, 15668.451604193855, 15669.059856408623, 15690.0, 15699.686006279868, 13695.246761428143, 14333.78499322511, 14349.354279057441, 14362.928185359086, 14382.856171438283, 845.4039901869168, 977.1889331854579, 978.3982850546898, 978.6134476881628, 978.6379039755265, 963.3930623707055, 977.7751117243039, 978.4911845840159, 980.1521683743546, 981.9410835349867, 1037.305005646219, 1041.536516250269, 1043.7599352149011, 1044.6291566493899, 1045.1482042135674, 1034.0125180452687, 1034.1519953637944, 1035.9430231337274, 1037.642013505347, 1038.859753933217, 769.7267470048164, 771.2865599320662, 771.5255118102383, 771.5602106799126, 773.5397438524069, 15829.525114246591, 15835.920820395939, 15867.92066039674, 15870.96838705492, 15883.444079457164, 12633.873661263453, 12727.554535591209, 12778.488860445572, 12817.102802803807, 13123.0, 10424.426656533888, 10453.9477302613, 11330.206885518017, 11639.301641901513, 11679.124065695107, 3544.6455354464606, 3575.0526110580718, 3594.802285874276, 3620.837062332175, 3780.5652349979828, 62509.37490625081, 79433.60283198605, 81562.18437815605, 82257.58871205666, 82712.17287827104, 9560.76098097553, 9676.274279429072, 9718.416894986323, 9885.011498850201, 9892.307538472238, 22205.22281720132, 22218.66671999921, 22259.554808903733, 22290.442738931655, 22292.554148917254, 7796.4932279401655, 7823.413244006609, 7868.488548244346, 8077.394195435366, 8183.222593853575, 3475.1833319169973, 4178.582141785797, 4236.915261694749, 4259.169461954889, 4437.445319335083, 3760.52993375828, 3826.3877779555137, 3832.616738326145, 3832.9233415332096, 3837.13664425502, 639.5107742576932, 691.920429150644, 692.854500554879, 694.9722011119499, 696.2098018748757, 559.7900787204799, 600.7236671131241, 602.8733965867129, 616.6608365399013, 636.5671343486381, 8069.878951815727, 8372.0, 8496.277816385676, 8517.446365986316, 8595.82808343842, 571.2316933724135, 579.0821547846626, 596.6449962272441, 601.0233370772495, 606.5087279303779, 3338.7996720196866, 3924.156306394139, 3970.7293666026594, 4011.3581826907553, 4141.834326626901, 84370.0, 85415.86460338542, 85624.0, 85787.0, 88283.23433531422, 78304.21695783084, 79693.0, 79924.60037699774, 80674.59662701766, 81138.78291825627, 67421.98867016999, 70686.293137069, 71224.64387678029, 71796.0, 72529.0, 7738.0, 7917.327027202522, 7955.363570914197, 8002.07976082758, 8155.118051590347, 41504.58495415007, 49126.0, 50557.49442505675, 51163.0, 52041.479585205176, 64166.67916660387, 64696.70606587936, 67055.0, 68736.31263687299, 68768.12318768083, 9696.272779541421, 10116.747081323027, 10162.288639795144, 10259.538320775433, 10563.260571759904, 8905.910940890508, 10988.780224395627, 11003.779924401628, 11331.206815522833, 11490.965813076864, 10405.687829365132, 10415.42715150674, 10544.89455105439, 10762.0, 10904.182186336215, 10286.485675716034, 10447.216458765472, 10471.581136754749, 10608.310459820395, 10960.890391095987, 10202.489875506344, 10268.897311026794, 10351.327163734333, 10926.56293748273, 11079.390633514911, 8733.825323493622, 8842.248408885316, 8878.0, 9087.727368178965, 9117.726468205965, 8992.235659968976, 9002.50486223264, 9032.412893161923, 9087.54562271897, 9133.588988495401], "value": 6972.010851122628, "unit": "score"}], "name": "dromaeo_css", "value": 7538.36485270985, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 119.0, 113.0, 111.0, 110.0, 111.0, 112.0, 112.0, 136.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 120.0, 142.0, 199.0, 146.0, 174.0, 139.0, 119.0, 181.0, 117.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 184.0, 185.0, 185.0, 184.0, 185.0, 185.0, 189.0, 223.0], "value": 189.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 81.0, 94.0, 187.0, 84.0, 55.0, 56.0, 57.0, 131.0, 55.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 147.0, 80.0, 78.0, 90.0, 126.0, 79.0, 78.0, 126.0], "value": 99.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 85.0, 87.0, 83.0, 88.0, 84.0, 87.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 115.0, 124.0, 92.0, 92.0, 93.0, 92.0, 93.0, 91.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 83.0, 85.0, 82.0, 87.0, 84.0, 84.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 83.0, 59.0, 56.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 68.0, 66.0, 76.0, 71.0, 68.0, 66.0, 65.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 100.0, 103.0, 78.0, 80.0, 79.0, 77.0, 79.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 125.0, 138.0, 130.0, 147.0, 139.0, 130.0, 166.0, 161.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 157.0, 159.0, 166.0, 166.0, 174.0, 163.0, 208.0, 209.0, 162.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 69.0, 67.0, 66.0, 66.0, 65.0, 68.0, 68.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1502.3, "alertThreshold": 2.0}]} 20:32:43 INFO - Return code: 0 20:32:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:32:43 ERROR - # TBPL SUCCESS # 20:32:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:32:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:32:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:32:43 INFO - 2016-07-18 20:32:43.673 screenresolution[1679:9725] starting screenresolution argv=screenresolution get 20:32:43 INFO - 2016-07-18 20:32:43.676 screenresolution[1679:9725] Display 0: 1600x1200x32@60 20:32:43 INFO - 2016-07-18 20:32:43.682 screenresolution[1680:9728] starting screenresolution argv=screenresolution list 20:32:43 INFO - Available Modes on Display 0 20:32:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:32:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:32:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:32:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:32:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:32:43 INFO - Intel Iris: 20:32:43 INFO - Chipset Model: Intel Iris 20:32:43 INFO - Type: GPU 20:32:43 INFO - Bus: Built-In 20:32:43 INFO - VRAM (Dynamic, Max): 1536 MB 20:32:43 INFO - Vendor: Intel (0x8086) 20:32:43 INFO - Device ID: 0x0a2e 20:32:43 INFO - Revision ID: 0x0009 20:32:43 INFO - Displays: 20:32:43 INFO - Display: 20:32:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:32:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:32:43 INFO - Display Serial Number: 1600x1200 60 20:32:43 INFO - Main Display: Yes 20:32:43 INFO - Mirror: Off 20:32:43 INFO - Online: Yes 20:32:43 INFO - Rotation: Supported 20:32:43 INFO - Return code: 0 20:32:43 INFO - Running post-action listener: _resource_record_post_action 20:32:43 INFO - Running post-run listener: _resource_record_post_run 20:32:44 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 37119488; Write bytes: 492278784; Read time: 243; Write time: 1563 20:32:44 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191345152; Write bytes: 184717312; Read time: 17260; Write time: 411 20:32:44 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 35337728; Write bytes: 296768512; Read time: 228; Write time: 1120 20:32:44 INFO - Running post-run listener: _upload_blobber_files 20:32:44 INFO - Blob upload gear active. 20:32:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:32:44 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 20:32:44 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'] 20:32:44 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 20:32:45 INFO - (blobuploader) - INFO - Open directory for files ... 20:32:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:32:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:32:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:46 INFO - (blobuploader) - INFO - Done attempting. 20:32:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:32:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:32:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:47 INFO - (blobuploader) - INFO - Done attempting. 20:32:47 INFO - (blobuploader) - INFO - Iteration through files over. 20:32:47 INFO - Return code: 0 20:32:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:32:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:32:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8769e9b3657b7a94062e508d91138780805c885e7960b5e3d1804ebc59d515fc6c49800e4be1b590257aa59afb69c58fc0c72be776c95126daa5abf677c39e3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1dad7ae8a648e1837a7672938308375f3079f93ee9a0ca3b298929b1487d0f756adaa775802c019783da91c5bfbfd85f0cc3e53635345e88732e0046472fb320"} 20:32:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:32:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:32:47 INFO - Contents: 20:32:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8769e9b3657b7a94062e508d91138780805c885e7960b5e3d1804ebc59d515fc6c49800e4be1b590257aa59afb69c58fc0c72be776c95126daa5abf677c39e3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1dad7ae8a648e1837a7672938308375f3079f93ee9a0ca3b298929b1487d0f756adaa775802c019783da91c5bfbfd85f0cc3e53635345e88732e0046472fb320"} 20:32:47 INFO - Running post-run listener: copy_logs_to_upload_dir 20:32:47 INFO - Copying logs to upload dir... 20:32:47 INFO - mkdir: /builds/slave/test/build/upload/logs 20:32:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.674078 ========= master_lag: 0.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-18 20:32:48.178156) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:32:48.181853) ========= 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.RTo9gmTu0O/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.0LQABS8mqy/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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/8769e9b3657b7a94062e508d91138780805c885e7960b5e3d1804ebc59d515fc6c49800e4be1b590257aa59afb69c58fc0c72be776c95126daa5abf677c39e3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1dad7ae8a648e1837a7672938308375f3079f93ee9a0ca3b298929b1487d0f756adaa775802c019783da91c5bfbfd85f0cc3e53635345e88732e0046472fb320"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010871 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8769e9b3657b7a94062e508d91138780805c885e7960b5e3d1804ebc59d515fc6c49800e4be1b590257aa59afb69c58fc0c72be776c95126daa5abf677c39e3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1dad7ae8a648e1837a7672938308375f3079f93ee9a0ca3b298929b1487d0f756adaa775802c019783da91c5bfbfd85f0cc3e53635345e88732e0046472fb320"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:32:48.219382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 20:32:48.219673) ========= 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.RTo9gmTu0O/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.0LQABS8mqy/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.004998 ========= master_lag: 1.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 20:32:49.517356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:32:49.517672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:32:49.520986) ========= ========= Total master_lag: 2.11 =========