builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0312 starttime: 1467943334.26 results: success (0) buildid: 20160706073558 builduid: a15f864cd7e24085b4dd36d56cf0d119 revision: 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:14.261051) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:14.261610) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:14.261979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:14.289011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:14.289387) ========= 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.ZwBTsS271R/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.AMOXDjQoGN/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-07 19:02:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.9M=0.001s 2016-07-07 19:02:14 (19.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123705 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:14.436037) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:14.436628) ========= 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.ZwBTsS271R/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.AMOXDjQoGN/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.025696 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:14.486323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:14.486748) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 --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 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZwBTsS271R/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.AMOXDjQoGN/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-07 19:02:14,571 truncating revision to first 12 chars 2016-07-07 19:02:14,571 Setting DEBUG logging. 2016-07-07 19:02:14,571 attempt 1/10 2016-07-07 19:02:14,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/85f50dde3d35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 19:02:15,265 unpacking tar archive at: mozilla-beta-85f50dde3d35/testing/mozharness/ program finished with exit code 0 elapsedTime=0.962202 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:15.474634) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:15.475431) ========= script_repo_revision: 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:15.476251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:15.476993) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:15.496531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-07 19:02:15.497221) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.ZwBTsS271R/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.AMOXDjQoGN/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:02:15 INFO - MultiFileLogger online at 20160707 19:02:15 in /builds/slave/test 19:02:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:02:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:02:15 INFO - {'append_to_log': False, 19:02:15 INFO - 'base_work_dir': '/builds/slave/test', 19:02:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:02:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:02:15 INFO - 'branch': 'Mozilla-Beta', 19:02:15 INFO - 'buildbot_json_path': 'buildprops.json', 19:02:15 INFO - 'config_files': ('talos/mac_config.py',), 19:02:15 INFO - 'default_actions': ('clobber', 19:02:15 INFO - 'read-buildbot-config', 19:02:15 INFO - 'download-and-extract', 19:02:15 INFO - 'populate-webroot', 19:02:15 INFO - 'create-virtualenv', 19:02:15 INFO - 'install', 19:02:15 INFO - 'run-tests'), 19:02:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:02:15 INFO - 'download_minidump_stackwalk': True, 19:02:15 INFO - 'download_symbols': 'ondemand', 19:02:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:02:15 INFO - 'tooltool.py': '/tools/tooltool.py', 19:02:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:02:15 INFO - '/tools/misc-python/virtualenv.py')}, 19:02:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:02:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:02:15 INFO - 'installer_path': 'installer.exe', 19:02:15 INFO - 'log_level': 'info', 19:02:15 INFO - 'log_name': 'talos', 19:02:15 INFO - 'log_to_console': True, 19:02:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:02:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:02:15 INFO - 'opt_config_files': (), 19:02:15 INFO - 'pip_index': False, 19:02:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:02:15 INFO - 'cmd': ('bash', 19:02:15 INFO - '-c', 19:02:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:02:15 INFO - 'enabled': True, 19:02:15 INFO - 'halt_on_failure': False, 19:02:15 INFO - 'name': 'check_screen_resolution'},), 19:02:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:02:15 INFO - 'cmd': ('bash', 19:02:15 INFO - '-c', 19:02:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:02:15 INFO - 'enabled': True, 19:02:15 INFO - 'halt_on_failure': False, 19:02:15 INFO - 'name': 'check_screen_resolution'},), 19:02:15 INFO - 'run_cmd_checks_enabled': True, 19:02:15 INFO - 'sps_profile': False, 19:02:15 INFO - 'sps_profile_interval': 0, 19:02:15 INFO - 'suite': 'dromaeojs-e10s', 19:02:15 INFO - 'system_bits': '32', 19:02:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:02:15 INFO - 'title': 't-yosemite-r7-0312', 19:02:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:02:15 INFO - 'use_talos_json': True, 19:02:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:02:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:02:15 INFO - 'work_dir': 'build'} 19:02:15 INFO - ##### 19:02:15 INFO - ##### Running clobber step. 19:02:15 INFO - ##### 19:02:15 INFO - Running pre-action listener: _resource_record_pre_action 19:02:15 INFO - Running main action method: clobber 19:02:15 INFO - rmtree: /builds/slave/test/build 19:02:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:02:18 INFO - Running post-action listener: _resource_record_post_action 19:02:18 INFO - ##### 19:02:18 INFO - ##### Running read-buildbot-config step. 19:02:18 INFO - ##### 19:02:18 INFO - Running pre-action listener: _resource_record_pre_action 19:02:18 INFO - Running main action method: read_buildbot_config 19:02:18 INFO - Using buildbot properties: 19:02:18 INFO - { 19:02:18 INFO - "project": "", 19:02:18 INFO - "product": "firefox", 19:02:18 INFO - "script_repo_revision": "production", 19:02:18 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 19:02:18 INFO - "repository": "", 19:02:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 19:02:18 INFO - "buildid": "20160706073558", 19:02:18 INFO - "pgo_build": "False", 19:02:18 INFO - "basedir": "/builds/slave/test", 19:02:18 INFO - "buildnumber": 18, 19:02:18 INFO - "slavename": "t-yosemite-r7-0312", 19:02:18 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:02:18 INFO - "platform": "yosemite_r7", 19:02:18 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:02:18 INFO - "branch": "mozilla-beta", 19:02:18 INFO - "repo_path": "releases/mozilla-beta", 19:02:18 INFO - "revision": "85f50dde3d351d93b571ac49ff71cf5140a2a3a7", 19:02:18 INFO - "stage_platform": "macosx64", 19:02:18 INFO - "builduid": "a15f864cd7e24085b4dd36d56cf0d119", 19:02:18 INFO - "slavebuilddir": "test" 19:02:18 INFO - } 19:02:18 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg. 19:02:18 INFO - Running post-action listener: _resource_record_post_action 19:02:18 INFO - ##### 19:02:18 INFO - ##### Running download-and-extract step. 19:02:18 INFO - ##### 19:02:18 INFO - Running pre-action listener: _resource_record_pre_action 19:02:18 INFO - Running main action method: download_and_extract 19:02:18 INFO - mkdir: /builds/slave/test/build/tests 19:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.test_packages.json 19:02:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 19:02:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/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 19:02:18 INFO - Downloaded 1165 bytes. 19:02:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 19:02:18 INFO - Using the following test package requirements: 19:02:18 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 19:02:18 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:18 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 19:02:18 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:18 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 19:02:18 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:02:18 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:18 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 19:02:18 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 19:02:18 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:18 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 19:02:18 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:18 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 19:02:18 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:18 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 19:02:18 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:18 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 19:02:18 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 19:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.common.tests.zip 19:02:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 19:02:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/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 19:02:18 INFO - Downloaded 18351403 bytes. 19:02:18 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'] 19:02:18 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 19:02:21 INFO - Return code: 0 19:02:21 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 19:02: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')]} 19:02:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.common.tests.zip 19:02:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 19:02:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/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 19:02:21 INFO - Downloaded 18351403 bytes. 19:02:21 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'] 19:02:21 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 19:02:25 INFO - Return code: 0 19:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:25 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.talos.tests.zip 19:02:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 19:02:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/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 19:02:25 INFO - Downloaded 10840145 bytes. 19:02:25 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'] 19:02:25 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 19:02:26 INFO - Return code: 0 19:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg 19:02:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 19:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 19:02:48 INFO - Downloaded 86190145 bytes. 19:02:48 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg 19:02:48 INFO - mkdir: /builds/slave/test/properties 19:02:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:02:48 INFO - Writing to file /builds/slave/test/properties/build_url 19:02:48 INFO - Contents: 19:02:48 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg 19:02:48 INFO - Running post-action listener: _resource_record_post_action 19:02:48 INFO - Running post-action listener: set_extra_try_arguments 19:02:48 INFO - ##### 19:02:48 INFO - ##### Running populate-webroot step. 19:02:48 INFO - ##### 19:02:48 INFO - Running pre-action listener: _resource_record_pre_action 19:02:48 INFO - Running main action method: populate_webroot 19:02:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:02:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:02:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:02:48 INFO - '--tppagecycles', 19:02:48 INFO - '7'], 19:02:48 INFO - 'tests': ['tsvgm']}}, 19:02:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:02:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:02:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:02:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:02:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['damp', 'tps']}, 19:02:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'tests': ['damp', 'tps']}, 19:02:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['dromaeo_dom']}, 19:02:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:02:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'other-e10s': {'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['tsvgx', 19:02:48 INFO - 'tsvgr_opacity', 19:02:48 INFO - 'tart', 19:02:48 INFO - 'tscrollx', 19:02:48 INFO - 'cart']}, 19:02:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:02:48 INFO - 'tsvgr_opacity', 19:02:48 INFO - 'tart', 19:02:48 INFO - 'tscrollx', 19:02:48 INFO - 'cart']}, 19:02:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['tp5o']}, 19:02:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'tests': ['tp5o']}, 19:02:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'talos_options': ['--disable-e10s', 19:02:48 INFO - '--xperf_path', 19:02:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:48 INFO - 'tests': ['tp5n']}, 19:02:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'talos_options': ['--xperf_path', 19:02:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:48 INFO - 'tests': ['tp5n']}}, 19:02:48 INFO - 'talos.zip': {'path': '', 19:02:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:02:48 INFO - Running post-action listener: _resource_record_post_action 19:02:48 INFO - ##### 19:02:48 INFO - ##### Running create-virtualenv step. 19:02:48 INFO - ##### 19:02:48 INFO - Running pre-action listener: _resource_record_pre_action 19:02:48 INFO - Running main action method: create_virtualenv 19:02:48 INFO - Creating virtualenv /builds/slave/test/build/venv 19:02:48 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 19:02:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:02:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:02:48 INFO - Using real prefix '/tools/python27' 19:02:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:02:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:02:51 INFO - Installing pip.................done. 19:02:51 INFO - Return code: 0 19:02:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:02:51 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')]} 19:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:51 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')]} 19:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:51 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 0x105f32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f42420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe009cdb0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dd1e00>, '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 0x105c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dccb20>, '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.ZwBTsS271R/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.AMOXDjQoGN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:02:51 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 19:02:51 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 19:02:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZwBTsS271R/Render', 19:02:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:51 INFO - 'HOME': '/Users/cltbld', 19:02:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:51 INFO - 'LOGNAME': 'cltbld', 19:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:51 INFO - 'MOZ_NO_REMOTE': '1', 19:02:51 INFO - 'NO_EM_RESTART': '1', 19:02:51 INFO - 'PAGER': '/bin/cat', 19:02:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:51 INFO - 'PWD': '/builds/slave/test', 19:02:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:51 INFO - 'SHELL': '/bin/bash', 19:02:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AMOXDjQoGN/Listeners', 19:02:51 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:02:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:51 INFO - 'USER': 'cltbld', 19:02:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:51 INFO - 'XPC_FLAGS': '0x0', 19:02:51 INFO - 'XPC_SERVICE_NAME': '0', 19:02:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:52 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 19:02:52 INFO - Cleaning up... 19:02:52 INFO - Return code: 0 19:02:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105f32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f42420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe009cdb0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dd1e00>, '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 0x105c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dccb20>, '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.ZwBTsS271R/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.AMOXDjQoGN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:02:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZwBTsS271R/Render', 19:02:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:52 INFO - 'HOME': '/Users/cltbld', 19:02:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:52 INFO - 'LOGNAME': 'cltbld', 19:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:52 INFO - 'MOZ_NO_REMOTE': '1', 19:02:52 INFO - 'NO_EM_RESTART': '1', 19:02:52 INFO - 'PAGER': '/bin/cat', 19:02:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:52 INFO - 'PWD': '/builds/slave/test', 19:02:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:52 INFO - 'SHELL': '/bin/bash', 19:02:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AMOXDjQoGN/Listeners', 19:02:52 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:02:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:52 INFO - 'USER': 'cltbld', 19:02:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:52 INFO - 'XPC_FLAGS': '0x0', 19:02:52 INFO - 'XPC_SERVICE_NAME': '0', 19:02:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:52 INFO - Downloading/unpacking psutil>=0.7.1 19:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:02:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:55 INFO - Installing collected packages: psutil 19:02:55 INFO - Running setup.py install for psutil 19:02:55 INFO - building 'psutil._psutil_osx' extension 19:02:55 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 19:02:56 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 19:02:56 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 19:02:56 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 19:02:56 INFO - building 'psutil._psutil_posix' extension 19:02:56 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 19:02:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:02:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:02:56 INFO - ^ 19:02:56 INFO - 1 warning generated. 19:02:56 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 19:02:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:56 INFO - Successfully installed psutil 19:02:56 INFO - Cleaning up... 19:02:56 INFO - Return code: 0 19:02:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:02:56 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')]} 19:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:56 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')]} 19:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:56 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 0x105f32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f42420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe009cdb0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dd1e00>, '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 0x105c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dccb20>, '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.ZwBTsS271R/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.AMOXDjQoGN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:02:56 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 19:02:56 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 19:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZwBTsS271R/Render', 19:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:56 INFO - 'HOME': '/Users/cltbld', 19:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:56 INFO - 'LOGNAME': 'cltbld', 19:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:56 INFO - 'MOZ_NO_REMOTE': '1', 19:02:56 INFO - 'NO_EM_RESTART': '1', 19:02:56 INFO - 'PAGER': '/bin/cat', 19:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:56 INFO - 'PWD': '/builds/slave/test', 19:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:56 INFO - 'SHELL': '/bin/bash', 19:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AMOXDjQoGN/Listeners', 19:02:56 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:56 INFO - 'USER': 'cltbld', 19:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:56 INFO - 'XPC_FLAGS': '0x0', 19:02:56 INFO - 'XPC_SERVICE_NAME': '0', 19:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:02:56 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 19:02:56 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 19:02:56 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 19:02:56 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 19:02:56 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 19:02:56 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 19:02:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:02:59 INFO - Installing collected packages: mozsystemmonitor 19:02:59 INFO - Running setup.py install for mozsystemmonitor 19:02:59 INFO - Successfully installed mozsystemmonitor 19:02:59 INFO - Cleaning up... 19:02:59 INFO - Return code: 0 19:02:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:02:59 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')]} 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:59 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')]} 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:59 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 0x105f32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f42420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe009cdb0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dd1e00>, '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 0x105c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dccb20>, '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.ZwBTsS271R/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.AMOXDjQoGN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:02:59 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 19:02:59 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 19:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZwBTsS271R/Render', 19:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:59 INFO - 'HOME': '/Users/cltbld', 19:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:59 INFO - 'LOGNAME': 'cltbld', 19:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:59 INFO - 'MOZ_NO_REMOTE': '1', 19:02:59 INFO - 'NO_EM_RESTART': '1', 19:02:59 INFO - 'PAGER': '/bin/cat', 19:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:59 INFO - 'PWD': '/builds/slave/test', 19:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:59 INFO - 'SHELL': '/bin/bash', 19:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AMOXDjQoGN/Listeners', 19:02:59 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:59 INFO - 'USER': 'cltbld', 19:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:59 INFO - 'XPC_FLAGS': '0x0', 19:02:59 INFO - 'XPC_SERVICE_NAME': '0', 19:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:59 INFO - Downloading/unpacking blobuploader==1.2.4 19:02:59 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 19:02:59 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 19:02:59 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 19:02:59 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 19:02:59 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 19:02:59 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 19:03:02 INFO - Downloading blobuploader-1.2.4.tar.gz 19:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:03:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:03:02 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 19:03:02 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 19:03:02 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 19:03:02 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 19:03:02 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 19:03:02 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 19:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:03:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:03:02 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 19:03:02 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 19:03:02 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 19:03:02 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 19:03:02 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 19:03:02 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 19:03:03 INFO - Downloading docopt-0.6.1.tar.gz 19:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:03:03 INFO - Installing collected packages: blobuploader, requests, docopt 19:03:03 INFO - Running setup.py install for blobuploader 19:03:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:03:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:03:03 INFO - Running setup.py install for requests 19:03:04 INFO - Running setup.py install for docopt 19:03:04 INFO - Successfully installed blobuploader requests docopt 19:03:04 INFO - Cleaning up... 19:03:04 INFO - Return code: 0 19:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:04 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 0x105f32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f42420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe009cdb0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dd1e00>, '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 0x105c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dccb20>, '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.ZwBTsS271R/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.AMOXDjQoGN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:03:04 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 19:03:04 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 19:03:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZwBTsS271R/Render', 19:03:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:04 INFO - 'HOME': '/Users/cltbld', 19:03:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:04 INFO - 'LOGNAME': 'cltbld', 19:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:04 INFO - 'MOZ_NO_REMOTE': '1', 19:03:04 INFO - 'NO_EM_RESTART': '1', 19:03:04 INFO - 'PAGER': '/bin/cat', 19:03:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:04 INFO - 'PWD': '/builds/slave/test', 19:03:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:04 INFO - 'SHELL': '/bin/bash', 19:03:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AMOXDjQoGN/Listeners', 19:03:04 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:03:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:04 INFO - 'USER': 'cltbld', 19:03:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:04 INFO - 'XPC_FLAGS': '0x0', 19:03:04 INFO - 'XPC_SERVICE_NAME': '0', 19:03:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-G_nngx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-taGFzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-2Q7D4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-MTbRTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-MEcaUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Qq3H9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-MwARkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UpeYgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-nzUQAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-fHb3lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-3mJhp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-q1W73u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-rqg9cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-WH_8R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-vx_fZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-i7bwf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-lMCTWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:03:06 INFO - Running setup.py install for manifestparser 19:03:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:03:06 INFO - Running setup.py install for mozcrash 19:03:06 INFO - Running setup.py install for mozdebug 19:03:06 INFO - Running setup.py install for mozdevice 19:03:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Running setup.py install for mozfile 19:03:07 INFO - Running setup.py install for mozhttpd 19:03:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Running setup.py install for mozinfo 19:03:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Running setup.py install for mozInstall 19:03:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Running setup.py install for mozleak 19:03:07 INFO - Running setup.py install for mozlog 19:03:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Running setup.py install for moznetwork 19:03:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Running setup.py install for mozprocess 19:03:08 INFO - Running setup.py install for mozprofile 19:03:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Running setup.py install for mozrunner 19:03:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Running setup.py install for mozscreenshot 19:03:08 INFO - Running setup.py install for moztest 19:03:08 INFO - Running setup.py install for mozversion 19:03:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:03:08 INFO - Cleaning up... 19:03:09 INFO - Return code: 0 19:03:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:09 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')]} 19:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:09 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')]} 19:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:09 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 0x105f32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f42420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe009cdb0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dd1e00>, '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 0x105c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dccb20>, '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.ZwBTsS271R/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.AMOXDjQoGN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:03:09 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 19:03:09 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 19:03:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZwBTsS271R/Render', 19:03:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:09 INFO - 'HOME': '/Users/cltbld', 19:03:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:09 INFO - 'LOGNAME': 'cltbld', 19:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:09 INFO - 'MOZ_NO_REMOTE': '1', 19:03:09 INFO - 'NO_EM_RESTART': '1', 19:03:09 INFO - 'PAGER': '/bin/cat', 19:03:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:09 INFO - 'PWD': '/builds/slave/test', 19:03:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:09 INFO - 'SHELL': '/bin/bash', 19:03:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AMOXDjQoGN/Listeners', 19:03:09 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:03:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:09 INFO - 'USER': 'cltbld', 19:03:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:09 INFO - 'XPC_FLAGS': '0x0', 19:03:09 INFO - 'XPC_SERVICE_NAME': '0', 19:03:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-2r3tau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Cb_HG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-P7gE17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-uQcbTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-OVtlkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-dZkAY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-2Uhacs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:10 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-XUD3sA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:10 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ba39FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:10 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Fc_A8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:10 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-qoMdJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:10 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PMiZK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:10 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-k6qPTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:10 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-fbRF5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:10 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Xyo5v1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:10 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-uKJHiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:10 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-V_LAmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:11 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)) 19:03:11 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)) 19:03:11 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)) 19:03:11 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)) 19:03:11 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)) 19:03:11 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)) 19:03:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:03:11 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 19:03:11 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 19:03:11 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 19:03:11 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 19:03:11 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 19:03:11 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 19:03:13 INFO - Downloading blessings-1.6.tar.gz 19:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:03:13 INFO - Installing collected packages: blessings 19:03:13 INFO - Running setup.py install for blessings 19:03:14 INFO - Successfully installed blessings 19:03:14 INFO - Cleaning up... 19:03:14 INFO - Return code: 0 19:03:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:03:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:03:14 INFO - Reading from file tmpfile_stdout 19:03:14 INFO - Current package versions: 19:03:14 INFO - blessings == 1.6 19:03:14 INFO - blobuploader == 1.2.4 19:03:14 INFO - docopt == 0.6.1 19:03:14 INFO - manifestparser == 1.1 19:03:14 INFO - mozInstall == 1.12 19:03:14 INFO - mozcrash == 0.17 19:03:14 INFO - mozdebug == 0.1 19:03:14 INFO - mozdevice == 0.48 19:03:14 INFO - mozfile == 1.2 19:03:14 INFO - mozhttpd == 0.7 19:03:14 INFO - mozinfo == 0.9 19:03:14 INFO - mozleak == 0.1 19:03:14 INFO - mozlog == 3.1 19:03:14 INFO - moznetwork == 0.27 19:03:14 INFO - mozprocess == 0.22 19:03:14 INFO - mozprofile == 0.28 19:03:14 INFO - mozrunner == 6.11 19:03:14 INFO - mozscreenshot == 0.1 19:03:14 INFO - mozsystemmonitor == 0.0 19:03:14 INFO - moztest == 0.7 19:03:14 INFO - mozversion == 1.4 19:03:14 INFO - psutil == 3.1.1 19:03:14 INFO - requests == 1.2.3 19:03:14 INFO - wsgiref == 0.1.2 19:03:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:14 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 0x105f32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f42420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe009cdb0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dd1e00>, '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 0x105c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dccb20>, '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.ZwBTsS271R/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.AMOXDjQoGN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:03:14 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 19:03:14 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 19:03:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZwBTsS271R/Render', 19:03:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:14 INFO - 'HOME': '/Users/cltbld', 19:03:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:14 INFO - 'LOGNAME': 'cltbld', 19:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:14 INFO - 'MOZ_NO_REMOTE': '1', 19:03:14 INFO - 'NO_EM_RESTART': '1', 19:03:14 INFO - 'PAGER': '/bin/cat', 19:03:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:14 INFO - 'PWD': '/builds/slave/test', 19:03:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:14 INFO - 'SHELL': '/bin/bash', 19:03:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AMOXDjQoGN/Listeners', 19:03:14 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:03:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:14 INFO - 'USER': 'cltbld', 19:03:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:14 INFO - 'XPC_FLAGS': '0x0', 19:03:14 INFO - 'XPC_SERVICE_NAME': '0', 19:03:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:15 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)) 19:03:15 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)) 19:03:15 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)) 19:03:15 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)) 19:03:15 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)) 19:03:15 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)) 19:03:15 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)) 19:03:15 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)) 19:03:15 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)) 19:03:15 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)) 19:03:15 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)) 19:03:15 INFO - Cleaning up... 19:03:15 INFO - Return code: 0 19:03:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:15 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 0x105f32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f42420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe009cdb0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dd1e00>, '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 0x105c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dccb20>, '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.ZwBTsS271R/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.AMOXDjQoGN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:03:15 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 19:03:15 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 19:03:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZwBTsS271R/Render', 19:03:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:15 INFO - 'HOME': '/Users/cltbld', 19:03:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:15 INFO - 'LOGNAME': 'cltbld', 19:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:15 INFO - 'MOZ_NO_REMOTE': '1', 19:03:15 INFO - 'NO_EM_RESTART': '1', 19:03:15 INFO - 'PAGER': '/bin/cat', 19:03:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:15 INFO - 'PWD': '/builds/slave/test', 19:03:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:15 INFO - 'SHELL': '/bin/bash', 19:03:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AMOXDjQoGN/Listeners', 19:03:15 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:03:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:15 INFO - 'USER': 'cltbld', 19:03:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:15 INFO - 'XPC_FLAGS': '0x0', 19:03:15 INFO - 'XPC_SERVICE_NAME': '0', 19:03:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:15 INFO - Downloading/unpacking jsonschema 19:03:15 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 19:03:15 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 19:03:15 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 19:03:15 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 19:03:15 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 19:03:15 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 19:03:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:03:17 INFO - Downloading/unpacking functools32 (from jsonschema) 19:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:03:18 INFO - warning: no files found matching '*.txt' 19:03:18 INFO - no previously-included directories found matching 'build' 19:03:18 INFO - no previously-included directories found matching 'dist' 19:03:18 INFO - no previously-included directories found matching '.git*' 19:03:18 INFO - Installing collected packages: jsonschema, functools32 19:03:18 INFO - Running setup.py install for functools32 19:03:18 INFO - warning: no files found matching '*.txt' 19:03:18 INFO - no previously-included directories found matching 'build' 19:03:18 INFO - no previously-included directories found matching 'dist' 19:03:18 INFO - no previously-included directories found matching '.git*' 19:03:18 INFO - Successfully installed jsonschema functools32 19:03:18 INFO - Cleaning up... 19:03:18 INFO - Return code: 0 19:03:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:18 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 0x105f32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f42420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe009cdb0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dd1e00>, '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 0x105c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dccb20>, '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.ZwBTsS271R/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.AMOXDjQoGN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:03:18 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 19:03:18 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 19:03:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZwBTsS271R/Render', 19:03:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:18 INFO - 'HOME': '/Users/cltbld', 19:03:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:18 INFO - 'LOGNAME': 'cltbld', 19:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:18 INFO - 'MOZ_NO_REMOTE': '1', 19:03:18 INFO - 'NO_EM_RESTART': '1', 19:03:18 INFO - 'PAGER': '/bin/cat', 19:03:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:18 INFO - 'PWD': '/builds/slave/test', 19:03:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:18 INFO - 'SHELL': '/bin/bash', 19:03:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AMOXDjQoGN/Listeners', 19:03:18 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:03:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:18 INFO - 'USER': 'cltbld', 19:03:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:18 INFO - 'XPC_FLAGS': '0x0', 19:03:18 INFO - 'XPC_SERVICE_NAME': '0', 19:03:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:18 INFO - Downloading/unpacking flake8 19:03:18 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 19:03:18 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 19:03:18 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 19:03:18 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 19:03:18 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 19:03:18 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 19:03:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:03:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:03:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:03:22 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 19:03:22 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 19:03:22 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 19:03:22 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 19:03:22 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 19:03:22 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 19:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:03:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:03:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:03:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:03:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:03:22 INFO - no previously-included directories found matching 'docs/_build' 19:03:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:03:22 INFO - Running setup.py install for pep8 19:03:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:03:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:03:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:03:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:03:22 INFO - no previously-included directories found matching 'docs/_build' 19:03:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:03:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:03:22 INFO - Cleaning up... 19:03:22 INFO - Return code: 0 19:03:22 INFO - Running post-action listener: _resource_record_post_action 19:03:22 INFO - Running post-action listener: _start_resource_monitoring 19:03:22 INFO - Starting resource monitoring. 19:03:22 INFO - ##### 19:03:22 INFO - ##### Running install step. 19:03:22 INFO - ##### 19:03:22 INFO - Running pre-action listener: _resource_record_pre_action 19:03:22 INFO - Running main action method: install 19:03:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:03:23 INFO - Reading from file tmpfile_stdout 19:03:23 INFO - Detecting whether we're running mozinstall >=1.0... 19:03:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:03:23 INFO - Reading from file tmpfile_stdout 19:03:23 INFO - Output received: 19:03:23 INFO - Usage: mozinstall [options] installer 19:03:23 INFO - Options: 19:03:23 INFO - -h, --help show this help message and exit 19:03:23 INFO - -d DEST, --destination=DEST 19:03:23 INFO - Directory to install application into. [default: 19:03:23 INFO - "/builds/slave/test"] 19:03:23 INFO - --app=APP Application being installed. [default: firefox] 19:03:23 INFO - mkdir: /builds/slave/test/build/application 19:03:23 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'] 19:03:23 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 19:03:45 INFO - Reading from file tmpfile_stdout 19:03:45 INFO - Output received: 19:03:45 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:03:45 INFO - Running post-action listener: _resource_record_post_action 19:03:45 INFO - ##### 19:03:45 INFO - ##### Running run-tests step. 19:03:45 INFO - ##### 19:03:45 INFO - Running pre-action listener: _resource_record_pre_action 19:03:45 INFO - Running main action method: run_tests 19:03:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:03:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:03:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:03:45 INFO - 2016-07-07 19:03:45.383 screenresolution[1645:7535] starting screenresolution argv=screenresolution get 19:03:45 INFO - 2016-07-07 19:03:45.386 screenresolution[1645:7535] Display 0: 1600x1200x32@60 19:03:45 INFO - 2016-07-07 19:03:45.392 screenresolution[1646:7537] starting screenresolution argv=screenresolution list 19:03:45 INFO - Available Modes on Display 0 19:03:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:03:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:03:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:03:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:03:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:03:45 INFO - Intel Iris: 19:03:45 INFO - Chipset Model: Intel Iris 19:03:45 INFO - Type: GPU 19:03:45 INFO - Bus: Built-In 19:03:45 INFO - VRAM (Dynamic, Max): 1536 MB 19:03:45 INFO - Vendor: Intel (0x8086) 19:03:45 INFO - Device ID: 0x0a2e 19:03:45 INFO - Revision ID: 0x0009 19:03:45 INFO - Displays: 19:03:45 INFO - Display: 19:03:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:03:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:03:45 INFO - Display Serial Number: 1600x1200 60 19:03:45 INFO - Main Display: Yes 19:03:45 INFO - Mirror: Off 19:03:45 INFO - Online: Yes 19:03:45 INFO - Rotation: Supported 19:03:45 INFO - Return code: 0 19:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:03:45 INFO - Python 2.7.3 19:03:45 INFO - Return code: 0 19:03:45 INFO - grabbing minidump binary from tooltool 19:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:45 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 0x105dd1e00>, '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 0x105c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dccb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:03:45 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 19:03:45 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 19:03:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:03:45 INFO - Return code: 0 19:03:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:03:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:03:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:03:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:03:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:03:46 INFO - Return code: 0 19:03:46 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:03:46 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:03:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZwBTsS271R/Render', 19:03:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:46 INFO - 'HOME': '/Users/cltbld', 19:03:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:46 INFO - 'LOGNAME': 'cltbld', 19:03:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:03:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:46 INFO - 'MOZ_NO_REMOTE': '1', 19:03:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:03:46 INFO - 'NO_EM_RESTART': '1', 19:03:46 INFO - 'PAGER': '/bin/cat', 19:03:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:46 INFO - 'PWD': '/builds/slave/test', 19:03:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:03:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:46 INFO - 'SHELL': '/bin/bash', 19:03:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AMOXDjQoGN/Listeners', 19:03:46 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:03:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:46 INFO - 'USER': 'cltbld', 19:03:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:46 INFO - 'XPC_FLAGS': '0x0', 19:03:46 INFO - 'XPC_SERVICE_NAME': '0', 19:03:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:03:47 INFO - mozversion application_buildid: 20160706073558 19:03:47 INFO - mozversion application_changeset: 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 19:03:47 INFO - mozversion application_display_name: Firefox 19:03:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:03:47 INFO - mozversion application_name: Firefox 19:03:47 INFO - mozversion application_remotingname: firefox 19:03:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:03:47 INFO - mozversion application_vendor: Mozilla 19:03:47 INFO - mozversion application_version: 48.0 19:03:47 INFO - mozversion platform_buildid: 20160706073558 19:03:47 INFO - mozversion platform_changeset: 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 19:03:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:03:47 INFO - mozversion platform_version: 48.0 19:03:47 INFO - using testdate: 1467943427 19:03:47 INFO - actual date: 1467943427 19:03:47 INFO - starting webserver on 'localhost:49278' 19:03:47 INFO - SUITE-START | Running 2 tests 19:03:47 INFO - TEST-START | dromaeo_css 19:03:47 INFO - operating with platform_type : mac_ 19:03:47 INFO - Initialising browser for dromaeo_css test... 19:03:47 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpcyD4V4/profile http://localhost:49278/getInfo.html) 19:03:49 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 19:03:49 INFO - PROCESS | 1664 | colorDepth:24 19:03:49 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 19:03:49 INFO - PROCESS | 1664 | __metrics 19:03:49 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 19:03:50 INFO - TEST-INFO | 1664: exit 0 19:03:50 INFO - Browser initialized. 19:03:50 INFO - Running cycle 1/1 for dromaeo_css test... 19:03:50 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpcyD4V4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:02 INFO - PROCESS | 1668 | RSS: Main: 171012096 19:04:02 INFO - PROCESS | 1668 | 19:04:52 INFO - PROCESS | 1668 | 1467943492228 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] 19:07:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 19:07:03 INFO - PROCESS | 1668 | RSS: Main: 185200640 19:07:03 INFO - PROCESS | 1668 | 19:10:05 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 19:10:06 INFO - PROCESS | 1668 | RSS: Main: 195846144 19:10:06 INFO - PROCESS | 1668 | 19:13:08 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 19:13:08 INFO - PROCESS | 1668 | RSS: Main: 197754880 19:13:08 INFO - PROCESS | 1668 | 19:16:10 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 19:16:11 INFO - PROCESS | 1668 | RSS: Main: 201523200 19:16:11 INFO - PROCESS | 1668 | 19:19:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 19:19:14 INFO - PROCESS | 1668 | RSS: Main: 200630272 19:19:14 INFO - PROCESS | 1668 | 19:22:16 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 19:22:16 INFO - PROCESS | 1668 | RSS: Main: 206430208 19:22:16 INFO - PROCESS | 1668 | 19:22:16 INFO - PROCESS | 1668 | __start_tp_report 19:22:16 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 19:22:16 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 19:22:16 INFO - PROCESS | 1668 | |i|pagename|runs| 19:22:16 INFO - PROCESS | 1668 | |0;dojo.html;3633.2551826875488;3665.981670091649;3676.099355657864;3697.2605478904225;3717.01499102738;5998.070299103635;5998.460138587527;6013.398660133985;6018.819435416934;6020.0367941129425;6013.669248191348;6023.698815059241;6028.246469191351;6047.062705280678;6079.4528492435675;5321.52106310432;5361.812336568201;5390.973045134769;5420.295361602986;5443.2107344435035;5338.092524270864;5371.435999220084;5420.430854760252;5480.369757477882;5522.2544956430975;4815.566599006089;5153.072446959546;5468.070428027225;5482.945170548283;5515.503604675579;5423.322084739408;5439.184122381655;5462.317210348707;5466.426025267329;5520.889582208333;5239.240310155044;5264.210368444764;5307.097793375136;5321.973390133063;5387.78448862045;5805.216295800055;5844.707764611752;5942.257217847769;5957.523398128139;5982.341942386334;6280.717367718464;6352.237731472253;6360.55476116672;6368.490520758328;6380.489560835122;6229;6233.594816336924;6353.523485738542;6390.3609639036185;6431.614103153779;6125.693715314216;6129.816105516842;6134.8159555213415;6158.7228574714245;6164.568480206387;6615.470762339001;6618.974059020859;6632.469402447792;6644.468442524587;6650.933490665128;6134.283518479771;6236.656983865931;6265.874682506415;6286.654234017173;6296.653684047421;6343.429091381798;6352.142460767737;6415.1981002374705;6416.903746443807;6421.4541763949655;6174.351693072253;6288.968555157195;6307;6311.990081586924;6312.589681670676;6229.190205273286;6302.338254483213;6302.432781049728;6330.746770129143;6335.65153916539;5047.192449208109;5068.113080210948;5078.5175408336145;5100.69395836251;5105.15764898795;4470.597646211857;4571.474280457724;4616.492185859553;4646.4888862225125;4649.256119020941;4759.619230461555;6111.5309653553995;6145.740123274718;6241.843953901098;6277.843053923689;6432.35676432353;6435.839104022343;6444.871102577922;6458.935410645928;6466.385693359123;6102.267727872683;6132.539076726543;6288.056791481223;6293.1504246927;6300.716467758962;5611.775528978795;5658.377578466366;5676.914846277309;5692.800751973744;5704.11586204139;6691.698873550702;6704.731810727516;6771.187457505131;6772.288909664611;6777.830554236183;6319.557630965788;6347.809565713036;6448.580842245239;6461.8061458156335;6487.643179625166;6617.43751781104;6732.932670673426;6752.831179220559;6771.322867713189;6781.491388146008;6340.9365906340345;6383.521235907233;6385.169927909342;6390;6406.935930640634;6245.531585131224;6329.398707122816;6333.113364129118;6423.935760642334;6441.549091563733;6161.876762464815;6244.531660125418;6249.718762655601;6262.624242545462;6269.247690277196;6037.366076562073;6223.3465486125115;6235;6256.593321434092;6363.5863668861375;6095.1466794647895;6118.040554665315;6123.953766440777;6189.257289125334;6234.657093859882;6201.844953876189;6240.812775616739;6269.435750782269;6272.498200143887;6317.989121740499;6220.502359811295;6224.035274532454;6225.844353891189;6237.688115594111;6270.529710271657 19:22:16 INFO - PROCESS | 1668 | |1;ext.html;547.4361407750016;548.550188845147;557.6124593407578;585.475998980912;615.1388056720593;36065.81967090164;39648.80175599122;39765.801170994106;39833.8008309958;39880.803575892736;41307.58692413075;41479.58520414795;41624.79187604058;41851.372229416585;42129.7893510532;9541.809163816702;9609.567569459392;9614.56734446948;9666.661666841663;9711.271654625896;9637.373570717917;9841.803163936716;9895.752606184868;9898.307118501707;9913.15738162257;9860.11258986691;9866.260030497706;9889.703308900744;9913.008699130065;9934.701958941207;9843.606255749797;9897.257705672104;9913.603455861758;9955.253355998293;9974.351667141613;9653.855192172123;9711;9757.609695612167;9760.755981100458;9767.902320976771;40026.79986600077;40124.799376003226;40193.19613607741;40444.19111617751;40848.97877553055;2833.195136814559;3177.2215807127172;3367.9831600842085;3495.755297129202;3537.2218112015316;26536.734632653814;26765;26967.32581685454;27254.727452725416;28163.29591760202;2225.6105181593157;2344.2146880794953;2706.553418685934;2835.333696581302;2883.927901802451;310966;311933.44033279916;313543;314237.4288128568;315912.8408715929;37046.62953370486;37839.243215135546;37854.81072594619;64318;64743;36333.8183309087;36392.636073638925;36656.63343366532;36661.81669091638;36713.449298260544;13455.730885382238;14607.634809129644;16353.67292654164;16571;16583.91708041476;11639.941800290944;13431.194128352136;13746.587602371945;13909.234992075331;13992;8402.663893444316;8465.068842427328;8476.364272679573;8533.701320453754;8566.657333706582;3279.917627183024;3442.6385229550538;3550.6981906538235;3620.5293311869814;3639.362286970874;927.5315965437411;989.5052473763119;1016.4765145949842;1118.6028959719345;1124.4771181400688;25305.18454689084;30205.69794302029;30590.84704576463;30926.53610195849;31281.68718312833;1069.896241939732;1144.8282757586428;1190.9047276217882;1262.7348256865978;1290.451558087809;12307;14513;14681.77977330341;14824.184669843262;15094.849051509344;425900;493482.0651793436;503899.48050259514;504050;513182;58362.708186458796;58407.70796145992;58470.12294815581;58955.11567326493;58961.41038589559;1565.4051460445185;1576.2670358283453;1582.8258891521923;1587.1112177180817;1597.416942815887;25320.113796017053;29290.267743306587;29857.402851943272;30296.394072118874;30393.392132157674;52142.435726928255;52940.73529632327;53191.4680853202;53579.73210133924;53857.46142538524;494541;494765;496867;497777;498008;25732.970681172545;26796.732032679425;26821.865890670422;26940.191794246202;26984.730152698223;43072.78463607787;44396.334054988554;44634.3304850421;44960.32559511544;46568.767156164;38657.42013869851;39055.21889562136;39737.60262397339;39809.2038159241;40294.79852600718;36282.637173627925;36339.091522712144;36778.81610592037;36875.26249474942;37076;35860.641393586775;35881.64118358783;35912.46561184708;36364.636353636124;37882.24235515329;31686.366272674877;32502.34995300128;33166;33358.49962250617;33480.66519334873;25340.239792806246;25368.619470708323;25458.872705636353;25463.10143367058;25603 19:22:16 INFO - PROCESS | 1668 | |2;jquery.html;361.60765569357255;371.53001453161744;403.18355330455825;411.174025690946;414.08900419078014;16091.436799712012;17406.564835879108;20552.794472055273;21365.931703414804;21369.786302136974;18014.81985180148;18250.726239106392;21334.786652133513;21629.78370216301;21988.560228795413;5799.739011744482;5824.621399609023;5994.07091900756;6052.878942421149;6081.604695694788;5936.228290322274;6035.60768550045;6047.546434017444;6055.909161362583;6083.026715725485;5701.486866182043;5966.552508561854;5969.283685957691;5974.193483879664;6002.759889604411;5775.624584402042;5776.249087618604;5862.472377486026;5886.352501224862;5930.822075337746;5093.2105523643895;5106.923396149061;5161.66449180802;5173.405058418292;5197.506236907488;24918.252452426455;25968.480630387476;26353.73646263532;26574;26838.5974210387;1618.441637635014;2192.1560199323376;2217.6119179143584;2230.620794464945;2433.197044975154;10292.691219263434;10299.588016479333;11918.880811191864;12079.094067944852;15040.247987600686;1752.2990803678504;1778.6976214043643;1838.3014454507336;1843.9907800460912;1932.391296741522;108419.45790270998;111669;112004.43997779959;115340;117431;9230.953845230732;9608.27937904646;11698.122640801974;11714.297142171497;11954.76090478203;15140.848591513944;15155.166465844484;15182.013169144191;15204.16377099248;15227.314770835339;9109.498977556166;9146.2225710814;9192.448453092837;9381.5309234538;9390.718278451657;9417.576209070608;9436.386634868712;9444.244460443148;9483.33616646842;9581.041895810364;4631.930521042187;4719.268513380432;4740.928886066712;4753.667243292936;4776.95223047772;1859.711744679577;1993.6212119697502;2069.286096296775;2073.4919944613366;2078.3349328214827;894.6466145872344;1012.4178597306578;1034.3897100710617;1044.253358848427;1073.8335557988523;18794.624107518048;19491.610167796563;20180;20385.388438346872;20438.69341959872;959.7792507723262;1011.1910471622673;1019.3119644240109;1019.3323373190572;1058.692979036071;10434.530446129942;10728.463576821285;10765.78468430627;10774.24580279373;10949;566176;648965;662548;665281;670886;114874;117080.82919170869;118384;120055;120978;1032.0762917189224;1034.2450011491653;1040.0743338428804;1049.8687664041995;1053.031211285619;16364.34542618282;16436.260368283696;17499;17612.823871761117;17662.823371766117;48479.757601213176;50630.24054639257;51045.744771277394;51863;52512.47487525076;75623.48753025019;75727;76179.61910190636;76391.61804190943;77356.61321693356;6727.461803055841;7819.408427474233;8106.310963567927;8141.348692104736;8302.916970830214;11056.391898445663;12018.158728888893;12233.938830305791;12595.93702031484;12736;10411.94794026025;10753.784924301626;10853.294535855144;10856.13150947938;10914.836277455686;9413.29400294967;10530.684079477322;10605.204609654462;10820.837687434538;10895.836562451728;10701.464926753786;10855.945720271347;11152;11160.162987775788;11251.831222531833;8102;8110.513369197867;8183.95908020456;8222.958885205775;8379.622916968872;9376.906230937604;10551.94724026375;10732.14142868553;11335.206535542433;11337.376444295312 19:22:16 INFO - PROCESS | 1668 | |3;mootools.html;1633.0446688687118;1642.802863656361;1890.2439024390242;1964.950876228094;2017.656998310287;8375.036870759865;9069.591868365922;9069.954650226757;9308.115729005742;9340.3461757677;9082.81834363314;9099.272058235325;9129.771755706111;9188.8621670675;9198.356115071947;2529.759672831078;2541.4535874786916;2543.326018605071;2545.6054311581734;2569.882101285937;2502.9249122526353;2552.7702506774385;2564.7307032761573;2574.729653386386;2580.161447529551;2520.5337012652626;2542.224621490445;2567.101514469939;2592.338953566838;2597.5194589001094;2553.8467691938545;2555.821092523524;2578.845269283849;2583.2250324902548;2583.8320509167033;2538.733432989528;2564.4614630927526;2587.792976561889;2589.7669209771025;2590.3912580543556;7516.361109305715;7780.988471498726;9232.353735238536;9307.16235538798;9308;5497.945020549823;5599.272094627713;5680.091185410356;5730.283714535642;5822.214001109838;3335;3479.5128681984543;3501.8774342897877;3590.7486475946694;3735.1595890924323;952.7951490429522;1069.8074346617607;1072.2762135558467;1072.4584085037006;1073.6671631794168;12319.753604927851;12467.93766031173;12498.312592807391;12508.937455312665;12523.937380313131;5006.549410553068;5011;5119.769610367543;5137.332146820964;5178.741062946913;10321;10350.844737328945;10571;10580.576776928836;10594.993475619804;5740.741666625012;5763.711814409263;5773;5777.768889244468;5782.566307526952;4646.79089440976;5057.140286151363;5170.1986192140275;5188.688678679291;5208.635395522353;3579.391503444421;4211.536730959592;4268.658507319407;4320.935185972213;4349.739015659071;1393.4495874129864;1398.3637444962517;1429.8713115819626;1444.1479527079073;1444.248990524921;806.9112397636255;830.4062595244429;965.9178969787647;976.2336565795816;983.4246965525105;5981.5214782817275;6004.42957918997;6039.063945088518;6097.603655762361;6230.376962303824;933.4306073295285;963.4412041016334;996.8056229035413;1002.8946960569035;1008.7730260691286;3987.501562304712;4024.6176613221696;4051.6961227908023;4066.755994640331;4085.673146148301;10726;10988.835167472495;11121.888781112248;11141.498632561392;11325.037371823488;11013.063889569316;11083.334999900031;11109.83335249972;11165.944170279097;11269;7633.809154771176;7763.262490063435;8619.1811777881;8662.133786621287;8667.783305417415;5989.760409583568;6006.519478441627;6112.327643959072;6112.816615501542;6174.845628859135;10144.594216231268;10209.693709188736;10336.741581460523;10359.792804144026;10365.274430789772;10073;10338;10550.366977981346;10585.576576936835;10726.946365268124;5997.610155339889;7595.5822429766895;7832.37341012729;7851.685932562634;7854.4894581851995;7055.541389809646;8430.494170349799;8591.140885911358;8662.436941598777;8694.478331300143;6433.935660643334;7470.738524151629;7632.084149902047;7663.69345226207;7671.923280767121;6861.55399899005;6953;7446.515976461513;7514;7557.735479258419;7195.964020179866;7247.673854676657;7280.381167600814;7294.63526823646;7325.890111648223;4995.475475075064;5011.599072074298;5076.695398276115;5090.287359769709;5096.0827051131155;5085;5127.1540195867265;5127.923081153711;5214.217867319932;5360.195970604441 19:22:16 INFO - PROCESS | 1668 | |4;prototype.html;336.14283576878967;337.2581211458863;338.0517647997367;344.5744505535664;346.5650608486349;6819.5226334156505;6899.586024838513;6905.758298459555;7004.474664400172;7024.192217894937;4864.586510146633;6904.2750511196355;6905.136857892763;6941.1670599528;6949.374556289933;5027.874303142433;5134.666246693953;5138.460461651529;5141.074606570815;5160.793568257265;5142.717150556718;5144.974275128619;5147.588192944574;5149.0731668299695;5187.247849061884;5057.822976195834;5090.389153301609;5099.770510327045;5103.336566246383;5118.616103792212;3690.3910854708943;4940.456475636326;4946.72792996385;5038.874028149289;5093.032323858473;4302.139572085595;4352.542982986773;4354.978225108885;4355.738655680638;4358.411614432042;6652.101966234545;6665.233498147727;6697.7655782047395;6704;6732.697028633724;5284.260203571503;5923.763049478016;6038.3659715729655;6039.124326972608;6042.516598672096;5607.8878422431735;7273.563586184846;7386.269933683509;7402.148752893432;7434.405247580181;4691.366665500182;4874.098291816025;4875.7074575525585;4876.171050921352;4894.755262236874;6349.714262858182;7888.56612886291;7931.72238971639;7946.404019698546;7985.441019128663;4988.201887697951;4988.5260900214425;4989.575886049726;4995.375578052744;5000.024995125988;5094.694318340911;5097.158968770112;5100.296842673389;5101.132807422747;5119.822440838628;6003.0695242237525;6013.669248191304;6018.789342372996;6025.427584379477;6025.6685882276015;5960.552958528127;7198.208197098315;7487.775366739006;7493.66278517468;7525.397968162534;1736.036499742655;1755.8507526860105;1764.700000999833;1765.2321240260528;1773.6364045370667;1063.5692544519482;1124.8031594470935;1125.0999200639455;1148.190525679394;1153.26191237608;6209.472194863397;7119.07452031243;7249.275072492814;7262.709491620381;7265.309795569412;5460.645058071213;7199.1361036675935;7845.254700803414;7853.057633084067;7875.921240787633;7112.324329188718;7231.421486281085;7236.891446628305;7239.312265334785;7240.565566066053;3966.960330396717;4096.774677392772;4123.876283711494;4147.564505726916;4148.522919864255;6571.2771595124495;8193.09875913649;8234.094249632535;8239.299659528888;8252.669893204205;6550.6069635822005;7920;8050.718224862102;8057.5165490070785;8076.273135417723;6559.311272316433;8202.712905048294;8218.096009438957;8220.83558328842;8225.876611850827;6262.405071518198;7568.281013303727;7770.261825126604;7874.606269686378;7877.606119693878;6145.354737752472;7649.273319034683;7649.579273140031;7667.808304792425;7670.7315243966195;6536.379043990813;8212.917870821215;8230.506169629842;8238.299744521782;8266.875996859932;4827.927581086216;4867.367242258625;4874.756262186947;4885.364902562644;4886.657933944732;7486.625668716433;7619.238076192337;7744.0319960005;7747.728829491166;7770.45606807518;7440.851182976418;7451.031365922396;7458.888116678146;7462;7497.737579184703;6201.906971395523;7451.44114191427;7469.365103966006;7481.551106933602;7486.737964171446;7016.473764467583;7060.223375428802;7257.709691612276;7292.197858235696;7294.598797066213;7471.140818805907;7504.549727016397;7505.099388073248;7520.924790752241;7523.210062943313;7064.894026589708;7157.498975071695;7272.636368181676;7347.33873951347;7348.853022939618 19:22:16 INFO - PROCESS | 1668 | |5;yui.html;681.087342960433;706.2513735440431;729.821193807517;783.5600968801233;792.4136139256948;15411.845881541181;15488;15650.982686125408;15703.764443533357;15727.056376617411;14378.49675261366;14690.192039437827;14754.188519631416;14755.631109222248;14807.703845923103;793.4723408933053;922.0502882031518;941.1717688434203;944.1596978688972;972.7276362618478;936.3071327217843;959.9760005999871;973.7370909854335;974.8586454964026;977.6333874796951;984.4044353166339;985.0297457004845;986.5264672956949;994.9552270147825;1036.9533370998286;886.8315020146216;969.7866469376726;981.3915372469079;986.8026394721048;1012.8278192707257;735.9264073592651;751.1887161865172;761.6306091545596;767.9923200768033;777.3975169243824;14677.48628797987;14869.851301487062;14872.405103795834;14874.702505949928;15010.924945375313;13083.084184107116;13194.340282985908;13291.601251962456;13351.132176408502;13365.465381384733;10261.79476410475;10293.485325733758;10399.06408423238;10432.269741118125;10632.787344253149;3552.946705799415;3575.213453040327;3592.8203589820664;3627.8004709740953;3665.7433979621437;55238.447615523735;78509;88999;89047;89439.55280223557;9746.75633109178;9787.412755234709;9831.86933502642;9852;9980.950095249478;17677.911610441864;21907.67138492924;22240;22253.66619500709;22406.551868962855;7686.654100565488;7809.882851757228;7830.8433831323055;7926.643301051351;7999.760007199793;3553.271579326232;4105.651019663303;4202.978985105116;4329.264025115738;4376.081022985145;2959.8964036258626;3332.5336851785137;3729.5710993236125;3766.8304926278383;3769.359208934488;671.4628297362091;675.5642610516189;679.9490038247151;691.0877641513155;692.3906961873519;534.7086785413184;543.7580276776796;600.6366148480193;603.2037710222464;609.1958614628647;7114.39527640146;8124.7562573122905;8245.340372770164;8306.54314012735;8349.874751878726;541.388231298638;555.5860883641712;582.1839820196209;591.8668299632549;598.4045874354957;3886.358750806142;3919.7844118573753;3941.467901833273;3955.6835453163676;4104.979475102665;91280;95069;95415;95497.04502954881;95585.5220723892;78167.43665126666;79916.60041699755;80350;80523.7921431179;81698.59150704327;71438.57122857514;72392;72592.2740772596;73671.63164184253;74147.14632134132;7794.2595453434105;7806.687732490636;7860.489068210548;7913.44605877583;7927.563983980936;35398.469022964164;48229;48229.75885120552;48640;51449;68624.6568767153;69196.30803692101;69350.65324673345;70540.58918821698;71068.28931710617;9899.851502227617;9987.500624968578;10005.249606279413;10164.796704066026;10337.17302615804;10879.945600271947;10987.61543345979;11009.889901100887;11428.94285528567;11472.88527114718;10238.232132589937;10284.331518451278;10311;10478.528466218886;10867.619633312795;10139.340942838691;10400.58397664085;10614.628488002883;10762.08522275584;11175.608853690082;10146.594136234467;10212.131968782736;10212.642557510748;10444.791104177722;10644.680659580225;8860;8880.644774208959;9094.499802510925;9131.908680913106;9266.166045055978;8922.955385223033;9006.909930900607;9049.095090490899;9074.863877041718;9162.175404213653 19:22:16 INFO - PROCESS | 1668 | __end_tp_report 19:22:16 INFO - PROCESS | 1668 | __start_cc_report 19:22:16 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,397 19:22:16 INFO - PROCESS | 1668 | __end_cc_report 19:22:16 INFO - PROCESS | 1668 | __startTimestamp1467944536730__endTimestamp 19:22:16 INFO - PROCESS | 1668 | 19:22:16 INFO - PROCESS | 1668 | ------- Summary: start ------- 19:22:16 INFO - PROCESS | 1668 | Number of tests: 6 19:22:16 INFO - PROCESS | 1668 | 19:22:16 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5964.10 Median:6225.84 stddev:649.63 (10.4%) stddev-sans-first:625.36 19:22:16 INFO - PROCESS | 1668 | Values: 3633.3 3666.0 3676.1 3697.3 3717.0 5998.1 5998.5 6013.4 6018.8 6020.0 6013.7 6023.7 6028.2 6047.1 6079.5 5321.5 5361.8 5391.0 5420.3 5443.2 5338.1 5371.4 5420.4 5480.4 5522.3 4815.6 5153.1 5468.1 5482.9 5515.5 5423.3 5439.2 5462.3 5466.4 5520.9 5239.2 5264.2 5307.1 5322.0 5387.8 5805.2 5844.7 5942.3 5957.5 5982.3 6280.7 6352.2 6360.6 6368.5 6380.5 6229.0 6233.6 6353.5 6390.4 6431.6 6125.7 6129.8 6134.8 6158.7 6164.6 6615.5 6619.0 6632.5 6644.5 6650.9 6134.3 6236.7 6265.9 6286.7 6296.7 6343.4 6352.1 6415.2 6416.9 6421.5 6174.4 6289.0 6307.0 6312.0 6312.6 6229.2 6302.3 6302.4 6330.7 6335.7 5047.2 5068.1 5078.5 5100.7 5105.2 4470.6 4571.5 4616.5 4646.5 4649.3 4759.6 6111.5 6145.7 6241.8 6277.8 6432.4 6435.8 6444.9 6458.9 6466.4 6102.3 6132.5 6288.1 6293.2 6300.7 5611.8 5658.4 5676.9 5692.8 5704.1 6691.7 6704.7 6771.2 6772.3 6777.8 6319.6 6347.8 6448.6 6461.8 6487.6 6617.4 6732.9 6752.8 6771.3 6781.5 6340.9 6383.5 6385.2 6390.0 6406.9 6245.5 6329.4 6333.1 6423.9 6441.5 6161.9 6244.5 6249.7 6262.6 6269.2 6037.4 6223.3 6235.0 6256.6 6363.6 6095.1 6118.0 6124.0 6189.3 6234.7 6201.8 6240.8 6269.4 6272.5 6318.0 6220.5 6224.0 6225.8 6237.7 6270.5 19:22:16 INFO - PROCESS | 1668 | 19:22:16 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:57166.90 Median:36827.04 stddev:117412.87 (318.8%) stddev-sans-first:117665.29 19:22:16 INFO - PROCESS | 1668 | Values: 547.4 548.6 557.6 585.5 615.1 36065.8 39648.8 39765.8 39833.8 39880.8 41307.6 41479.6 41624.8 41851.4 42129.8 9541.8 9609.6 9614.6 9666.7 9711.3 9637.4 9841.8 9895.8 9898.3 9913.2 9860.1 9866.3 9889.7 9913.0 9934.7 9843.6 9897.3 9913.6 9955.3 9974.4 9653.9 9711.0 9757.6 9760.8 9767.9 40026.8 40124.8 40193.2 40444.2 40849.0 2833.2 3177.2 3368.0 3495.8 3537.2 26536.7 26765.0 26967.3 27254.7 28163.3 2225.6 2344.2 2706.6 2835.3 2883.9 310966.0 311933.4 313543.0 314237.4 315912.8 37046.6 37839.2 37854.8 64318.0 64743.0 36333.8 36392.6 36656.6 36661.8 36713.4 13455.7 14607.6 16353.7 16571.0 16583.9 11639.9 13431.2 13746.6 13909.2 13992.0 8402.7 8465.1 8476.4 8533.7 8566.7 3279.9 3442.6 3550.7 3620.5 3639.4 927.5 989.5 1016.5 1118.6 1124.5 25305.2 30205.7 30590.8 30926.5 31281.7 1069.9 1144.8 1190.9 1262.7 1290.5 12307.0 14513.0 14681.8 14824.2 15094.8 425900.0 493482.1 503899.5 504050.0 513182.0 58362.7 58407.7 58470.1 58955.1 58961.4 1565.4 1576.3 1582.8 1587.1 1597.4 25320.1 29290.3 29857.4 30296.4 30393.4 52142.4 52940.7 53191.5 53579.7 53857.5 494541.0 494765.0 496867.0 497777.0 498008.0 25733.0 26796.7 26821.9 26940.2 26984.7 43072.8 44396.3 44634.3 44960.3 46568.8 38657.4 39055.2 39737.6 39809.2 40294.8 36282.6 36339.1 36778.8 36875.3 37076.0 35860.6 35881.6 35912.5 36364.6 37882.2 31686.4 32502.3 33166.0 33358.5 33480.7 25340.2 25368.6 25458.9 25463.1 25603.0 19:22:16 INFO - PROCESS | 1668 | 19:22:16 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:35705.43 Median:21350.36 stddev:106734.66 (499.9%) stddev-sans-first:107001.09 19:22:16 INFO - PROCESS | 1668 | Values: 361.6 371.5 403.2 411.2 414.1 16091.4 17406.6 20552.8 21365.9 21369.8 18014.8 18250.7 21334.8 21629.8 21988.6 5799.7 5824.6 5994.1 6052.9 6081.6 5936.2 6035.6 6047.5 6055.9 6083.0 5701.5 5966.6 5969.3 5974.2 6002.8 5775.6 5776.2 5862.5 5886.4 5930.8 5093.2 5106.9 5161.7 5173.4 5197.5 24918.3 25968.5 26353.7 26574.0 26838.6 1618.4 2192.2 2217.6 2230.6 2433.2 10292.7 10299.6 11918.9 12079.1 15040.2 1752.3 1778.7 1838.3 1844.0 1932.4 108419.5 111669.0 112004.4 115340.0 117431.0 9231.0 9608.3 11698.1 11714.3 11954.8 15140.8 15155.2 15182.0 15204.2 15227.3 9109.5 9146.2 9192.4 9381.5 9390.7 9417.6 9436.4 9444.2 9483.3 9581.0 4631.9 4719.3 4740.9 4753.7 4777.0 1859.7 1993.6 2069.3 2073.5 2078.3 894.6 1012.4 1034.4 1044.3 1073.8 18794.6 19491.6 20180.0 20385.4 20438.7 959.8 1011.2 1019.3 1019.3 1058.7 10434.5 10728.5 10765.8 10774.2 10949.0 566176.0 648965.0 662548.0 665281.0 670886.0 114874.0 117080.8 118384.0 120055.0 120978.0 1032.1 1034.2 1040.1 1049.9 1053.0 16364.3 16436.3 17499.0 17612.8 17662.8 48479.8 50630.2 51045.7 51863.0 52512.5 75623.5 75727.0 76179.6 76391.6 77356.6 6727.5 7819.4 8106.3 8141.3 8302.9 11056.4 12018.2 12233.9 12595.9 12736.0 10411.9 10753.8 10853.3 10856.1 10914.8 9413.3 10530.7 10605.2 10820.8 10895.8 10701.5 10855.9 11152.0 11160.2 11251.8 8102.0 8110.5 8184.0 8223.0 8379.6 9376.9 10551.9 10732.1 11335.2 11337.4 19:22:16 INFO - PROCESS | 1668 | 19:22:16 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5923.75 Median:5034.37 stddev:3290.83 (65.4%) stddev-sans-first:3284.26 19:22:16 INFO - PROCESS | 1668 | Values: 1633.0 1642.8 1890.2 1965.0 2017.7 8375.0 9069.6 9070.0 9308.1 9340.3 9082.8 9099.3 9129.8 9188.9 9198.4 2529.8 2541.5 2543.3 2545.6 2569.9 2502.9 2552.8 2564.7 2574.7 2580.2 2520.5 2542.2 2567.1 2592.3 2597.5 2553.8 2555.8 2578.8 2583.2 2583.8 2538.7 2564.5 2587.8 2589.8 2590.4 7516.4 7781.0 9232.4 9307.2 9308.0 5497.9 5599.3 5680.1 5730.3 5822.2 3335.0 3479.5 3501.9 3590.7 3735.2 952.8 1069.8 1072.3 1072.5 1073.7 12319.8 12467.9 12498.3 12508.9 12523.9 5006.5 5011.0 5119.8 5137.3 5178.7 10321.0 10350.8 10571.0 10580.6 10595.0 5740.7 5763.7 5773.0 5777.8 5782.6 4646.8 5057.1 5170.2 5188.7 5208.6 3579.4 4211.5 4268.7 4320.9 4349.7 1393.4 1398.4 1429.9 1444.1 1444.2 806.9 830.4 965.9 976.2 983.4 5981.5 6004.4 6039.1 6097.6 6230.4 933.4 963.4 996.8 1002.9 1008.8 3987.5 4024.6 4051.7 4066.8 4085.7 10726.0 10988.8 11121.9 11141.5 11325.0 11013.1 11083.3 11109.8 11165.9 11269.0 7633.8 7763.3 8619.2 8662.1 8667.8 5989.8 6006.5 6112.3 6112.8 6174.8 10144.6 10209.7 10336.7 10359.8 10365.3 10073.0 10338.0 10550.4 10585.6 10726.9 5997.6 7595.6 7832.4 7851.7 7854.5 7055.5 8430.5 8591.1 8662.4 8694.5 6433.9 7470.7 7632.1 7663.7 7671.9 6861.6 6953.0 7446.5 7514.0 7557.7 7196.0 7247.7 7280.4 7294.6 7325.9 4995.5 5011.6 5076.7 5090.3 5096.1 5085.0 5127.2 5127.9 5214.2 5360.2 19:22:16 INFO - PROCESS | 1668 | 19:22:16 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:6038.11 Median:6700.88 stddev:1938.77 (28.9%) stddev-sans-first:1896.39 19:22:16 INFO - PROCESS | 1668 | Values: 336.1 337.3 338.1 344.6 346.6 6819.5 6899.6 6905.8 7004.5 7024.2 4864.6 6904.3 6905.1 6941.2 6949.4 5027.9 5134.7 5138.5 5141.1 5160.8 5142.7 5145.0 5147.6 5149.1 5187.2 5057.8 5090.4 5099.8 5103.3 5118.6 3690.4 4940.5 4946.7 5038.9 5093.0 4302.1 4352.5 4355.0 4355.7 4358.4 6652.1 6665.2 6697.8 6704.0 6732.7 5284.3 5923.8 6038.4 6039.1 6042.5 5607.9 7273.6 7386.3 7402.1 7434.4 4691.4 4874.1 4875.7 4876.2 4894.8 6349.7 7888.6 7931.7 7946.4 7985.4 4988.2 4988.5 4989.6 4995.4 5000.0 5094.7 5097.2 5100.3 5101.1 5119.8 6003.1 6013.7 6018.8 6025.4 6025.7 5960.6 7198.2 7487.8 7493.7 7525.4 1736.0 1755.9 1764.7 1765.2 1773.6 1063.6 1124.8 1125.1 1148.2 1153.3 6209.5 7119.1 7249.3 7262.7 7265.3 5460.6 7199.1 7845.3 7853.1 7875.9 7112.3 7231.4 7236.9 7239.3 7240.6 3967.0 4096.8 4123.9 4147.6 4148.5 6571.3 8193.1 8234.1 8239.3 8252.7 6550.6 7920.0 8050.7 8057.5 8076.3 6559.3 8202.7 8218.1 8220.8 8225.9 6262.4 7568.3 7770.3 7874.6 7877.6 6145.4 7649.3 7649.6 7667.8 7670.7 6536.4 8212.9 8230.5 8238.3 8266.9 4827.9 4867.4 4874.8 4885.4 4886.7 7486.6 7619.2 7744.0 7747.7 7770.5 7440.9 7451.0 7458.9 7462.0 7497.7 6201.9 7451.4 7469.4 7481.6 7486.7 7016.5 7060.2 7257.7 7292.2 7294.6 7471.1 7504.5 7505.1 7520.9 7523.2 7064.9 7157.5 7272.6 7347.3 7348.9 19:22:16 INFO - PROCESS | 1668 | 19:22:16 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18352.49 Median:640.33 stddev:26267.88 (4102.2%) stddev-sans-first:26308.05 19:22:16 INFO - PROCESS | 1668 | Values: 681.1 706.3 729.8 783.6 792.4 15411.8 15488.0 15651.0 15703.8 15727.1 14378.5 14690.2 14754.2 14755.6 14807.7 793.5 922.1 941.2 944.2 972.7 936.3 960.0 973.7 974.9 977.6 984.4 985.0 986.5 995.0 1037.0 886.8 969.8 981.4 986.8 1012.8 735.9 751.2 761.6 768.0 777.4 14677.5 14869.9 14872.4 14874.7 15010.9 13083.1 13194.3 13291.6 13351.1 13365.5 10261.8 10293.5 10399.1 10432.3 10632.8 3552.9 3575.2 3592.8 3627.8 3665.7 55238.4 78509.0 88999.0 89047.0 89439.6 9746.8 9787.4 9831.9 9852.0 9981.0 17677.9 21907.7 22240.0 22253.7 22406.6 7686.7 7809.9 7830.8 7926.6 7999.8 3553.3 4105.7 4203.0 4329.3 4376.1 2959.9 3332.5 3729.6 3766.8 3769.4 671.5 675.6 679.9 691.1 692.4 534.7 543.8 600.6 603.2 609.2 7114.4 8124.8 8245.3 8306.5 8349.9 541.4 555.6 582.2 591.9 598.4 3886.4 3919.8 3941.5 3955.7 4105.0 91280.0 95069.0 95415.0 95497.0 95585.5 78167.4 79916.6 80350.0 80523.8 81698.6 71438.6 72392.0 72592.3 73671.6 74147.1 7794.3 7806.7 7860.5 7913.4 7927.6 35398.5 48229.0 48229.8 48640.0 51449.0 68624.7 69196.3 69350.7 70540.6 71068.3 9899.9 9987.5 10005.2 10164.8 10337.2 10879.9 10987.6 11009.9 11428.9 11472.9 10238.2 10284.3 10311.0 10478.5 10867.6 10139.3 10400.6 10614.6 10762.1 11175.6 10146.6 10212.1 10212.6 10444.8 10644.7 8860.0 8880.6 9094.5 9131.9 9266.2 8923.0 9006.9 9049.1 9074.9 9162.2 19:22:16 INFO - PROCESS | 1668 | -------- Summary: end -------- 19:22:16 INFO - PROCESS | 1668 | 19:22:17 INFO - TEST-INFO | 1668: exit 0 19:22:17 INFO - TEST-OK | dromaeo_css | took 1110317ms 19:22:17 INFO - TEST-START | kraken 19:22:17 INFO - operating with platform_type : mac_ 19:22:17 INFO - Initialising browser for kraken test... 19:22:17 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpHlhXxc/profile http://localhost:49278/getInfo.html) 19:22:19 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 19:22:19 INFO - PROCESS | 1680 | colorDepth:24 19:22:19 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 19:22:19 INFO - PROCESS | 1680 | __metrics 19:22:19 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 19:22:20 INFO - TEST-INFO | 1680: exit 0 19:22:20 INFO - Browser initialized. 19:22:20 INFO - Running cycle 1/1 for kraken test... 19:22:20 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpHlhXxc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:32 INFO - PROCESS | 1684 | RSS: Main: 170917888 19:22:32 INFO - PROCESS | 1684 | 19:22:35 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 19:22:36 INFO - PROCESS | 1684 | RSS: Main: 183635968 19:22:36 INFO - PROCESS | 1684 | 19:22:38 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 19:22:39 INFO - PROCESS | 1684 | RSS: Main: 192843776 19:22:39 INFO - PROCESS | 1684 | 19:22:42 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 19:22:43 INFO - PROCESS | 1684 | RSS: Main: 193814528 19:22:43 INFO - PROCESS | 1684 | 19:22:45 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 19:22:46 INFO - PROCESS | 1684 | RSS: Main: 196653056 19:22:46 INFO - PROCESS | 1684 | 19:22:48 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:22:48 INFO - PROCESS | 1684 | RSS: Main: 197160960 19:22:48 INFO - PROCESS | 1684 | 19:22:51 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 19:22:52 INFO - PROCESS | 1684 | RSS: Main: 198029312 19:22:52 INFO - PROCESS | 1684 | 19:22:55 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 19:22:56 INFO - PROCESS | 1684 | RSS: Main: 198094848 19:22:56 INFO - PROCESS | 1684 | 19:22:59 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 19:22:59 INFO - PROCESS | 1684 | RSS: Main: 198336512 19:22:59 INFO - PROCESS | 1684 | 19:23:01 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:23:02 INFO - PROCESS | 1684 | RSS: Main: 197763072 19:23:02 INFO - PROCESS | 1684 | 19:23:04 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:23:04 INFO - PROCESS | 1684 | RSS: Main: 197779456 19:23:04 INFO - PROCESS | 1684 | 19:23:06 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:23:07 INFO - PROCESS | 1684 | RSS: Main: 197758976 19:23:07 INFO - PROCESS | 1684 | 19:23:10 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:23:10 INFO - PROCESS | 1684 | RSS: Main: 197877760 19:23:10 INFO - PROCESS | 1684 | 19:23:13 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:23:14 INFO - PROCESS | 1684 | RSS: Main: 197947392 19:23:14 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 19:23:16 INFO - PROCESS | 1684 | RSS: Main: 199925760 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | __start_tp_report 19:23:16 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 19:23:16 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 19:23:16 INFO - PROCESS | 1684 | |i|pagename|runs| 19:23:16 INFO - PROCESS | 1684 | |0;ai-astar;115;121;110;117;118;134;118;117;122;125 19:23:16 INFO - PROCESS | 1684 | |1;audio-beat-detection;151;126;142;158;120;138;123;156;195;154 19:23:16 INFO - PROCESS | 1684 | |2;audio-dft;229;181;262;276;198;202;257;239;203;199 19:23:16 INFO - PROCESS | 1684 | |3;audio-fft;66;69;86;143;64;81;84;93;125;57 19:23:16 INFO - PROCESS | 1684 | |4;audio-oscillator;79;80;121;80;84;82;121;80;81;129 19:23:16 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;136;133;92;79;136;126;93;89;134;92 19:23:16 INFO - PROCESS | 1684 | |6;imaging-darkroom;98;93;142;150;150;110;154;149;97;97 19:23:16 INFO - PROCESS | 1684 | |7;imaging-desaturate;97;93;89;89;116;127;91;92;92;117 19:23:16 INFO - PROCESS | 1684 | |8;json-parse-financial;61;70;98;98;98;96;66;79;63;60 19:23:16 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;67;61;86;95;112;101;67;68;66;65 19:23:16 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;82;80;82;84;82;78;83;80;81;84 19:23:16 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;133;125;123;126;124;126;126;122;147;179 19:23:16 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;169;178;160;220;180;196;217;225;181;177 19:23:16 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;90;103;99;66;68;68;68;67;66;69 19:23:16 INFO - PROCESS | 1684 | __end_tp_report 19:23:16 INFO - PROCESS | 1684 | __start_cc_report 19:23:16 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1041 19:23:16 INFO - PROCESS | 1684 | __end_cc_report 19:23:16 INFO - PROCESS | 1684 | __startTimestamp1467944596636__endTimestamp 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | ------- Summary: start ------- 19:23:16 INFO - PROCESS | 1684 | Number of tests: 14 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:119.70 Median:119.50 stddev:6.46 (5.4%) stddev-sans-first:6.63 19:23:16 INFO - PROCESS | 1684 | Values: 115.0 121.0 110.0 117.0 118.0 134.0 118.0 117.0 122.0 125.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:152.50 stddev:22.16 (14.5%) stddev-sans-first:23.43 19:23:16 INFO - PROCESS | 1684 | Values: 151.0 126.0 142.0 158.0 120.0 138.0 123.0 156.0 195.0 154.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:224.60 Median:234.00 stddev:32.59 (13.9%) stddev-sans-first:34.53 19:23:16 INFO - PROCESS | 1684 | Values: 229.0 181.0 262.0 276.0 198.0 202.0 257.0 239.0 203.0 199.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:86.80 Median:75.00 stddev:27.60 (36.8%) stddev-sans-first:28.23 19:23:16 INFO - PROCESS | 1684 | Values: 66.0 69.0 86.0 143.0 64.0 81.0 84.0 93.0 125.0 57.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:80.00 stddev:20.84 (26.0%) stddev-sans-first:21.41 19:23:16 INFO - PROCESS | 1684 | Values: 79.0 80.0 121.0 80.0 84.0 82.0 121.0 80.0 81.0 129.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:111.00 Median:84.00 stddev:23.67 (28.2%) stddev-sans-first:23.31 19:23:16 INFO - PROCESS | 1684 | Values: 136.0 133.0 92.0 79.0 136.0 126.0 93.0 89.0 134.0 92.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:124.00 Median:123.50 stddev:26.86 (21.7%) stddev-sans-first:26.79 19:23:16 INFO - PROCESS | 1684 | Values: 98.0 93.0 142.0 150.0 150.0 110.0 154.0 149.0 97.0 97.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:100.30 Median:91.50 stddev:14.07 (15.4%) stddev-sans-first:14.87 19:23:16 INFO - PROCESS | 1684 | Values: 97.0 93.0 89.0 89.0 116.0 127.0 91.0 92.0 92.0 117.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:78.90 Median:87.50 stddev:16.88 (19.3%) stddev-sans-first:16.61 19:23:16 INFO - PROCESS | 1684 | Values: 61.0 70.0 98.0 98.0 98.0 96.0 66.0 79.0 63.0 60.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:78.80 Median:67.00 stddev:18.18 (27.1%) stddev-sans-first:18.78 19:23:16 INFO - PROCESS | 1684 | Values: 67.0 61.0 86.0 95.0 112.0 101.0 67.0 68.0 66.0 65.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.90 (2.3%) stddev-sans-first:2.01 19:23:16 INFO - PROCESS | 1684 | Values: 82.0 80.0 82.0 84.0 82.0 78.0 83.0 80.0 81.0 84.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:126.00 stddev:17.72 (14.1%) stddev-sans-first:18.79 19:23:16 INFO - PROCESS | 1684 | Values: 133.0 125.0 123.0 126.0 124.0 126.0 126.0 122.0 147.0 179.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.30 Median:188.50 stddev:22.91 (12.2%) stddev-sans-first:22.97 19:23:16 INFO - PROCESS | 1684 | Values: 169.0 178.0 160.0 220.0 180.0 196.0 217.0 225.0 181.0 177.0 19:23:16 INFO - PROCESS | 1684 | 19:23:16 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:68.00 stddev:14.81 (21.8%) stddev-sans-first:14.87 19:23:16 INFO - PROCESS | 1684 | Values: 90.0 103.0 99.0 66.0 68.0 68.0 68.0 67.0 66.0 69.0 19:23:16 INFO - PROCESS | 1684 | -------- Summary: end -------- 19:23:16 INFO - PROCESS | 1684 | 19:23:17 INFO - TEST-INFO | 1684: exit 0 19:23:17 INFO - TEST-OK | kraken | took 60023ms 19:23:17 INFO - SUITE-END | took 1170s 19:23:17 INFO - Completed test suite (00:19:30) 19:23:17 INFO - javascript benchmark 19:23:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3633.2551826875488, 3665.981670091649, 3676.099355657864, 3697.2605478904225, 3717.01499102738, 5998.070299103635, 5998.460138587527, 6013.398660133985, 6018.819435416934, 6020.0367941129425, 6013.669248191348, 6023.698815059241, 6028.246469191351, 6047.062705280678, 6079.4528492435675, 5321.52106310432, 5361.812336568201, 5390.973045134769, 5420.295361602986, 5443.2107344435035, 5338.092524270864, 5371.435999220084, 5420.430854760252, 5480.369757477882, 5522.2544956430975, 4815.566599006089, 5153.072446959546, 5468.070428027225, 5482.945170548283, 5515.503604675579, 5423.322084739408, 5439.184122381655, 5462.317210348707, 5466.426025267329, 5520.889582208333, 5239.240310155044, 5264.210368444764, 5307.097793375136, 5321.973390133063, 5387.78448862045, 5805.216295800055, 5844.707764611752, 5942.257217847769, 5957.523398128139, 5982.341942386334, 6280.717367718464, 6352.237731472253, 6360.55476116672, 6368.490520758328, 6380.489560835122, 6229.0, 6233.594816336924, 6353.523485738542, 6390.3609639036185, 6431.614103153779, 6125.693715314216, 6129.816105516842, 6134.8159555213415, 6158.7228574714245, 6164.568480206387, 6615.470762339001, 6618.974059020859, 6632.469402447792, 6644.468442524587, 6650.933490665128, 6134.283518479771, 6236.656983865931, 6265.874682506415, 6286.654234017173, 6296.653684047421, 6343.429091381798, 6352.142460767737, 6415.1981002374705, 6416.903746443807, 6421.4541763949655, 6174.351693072253, 6288.968555157195, 6307.0, 6311.990081586924, 6312.589681670676, 6229.190205273286, 6302.338254483213, 6302.432781049728, 6330.746770129143, 6335.65153916539, 5047.192449208109, 5068.113080210948, 5078.5175408336145, 5100.69395836251, 5105.15764898795, 4470.597646211857, 4571.474280457724, 4616.492185859553, 4646.4888862225125, 4649.256119020941, 4759.619230461555, 6111.5309653553995, 6145.740123274718, 6241.843953901098, 6277.843053923689, 6432.35676432353, 6435.839104022343, 6444.871102577922, 6458.935410645928, 6466.385693359123, 6102.267727872683, 6132.539076726543, 6288.056791481223, 6293.1504246927, 6300.716467758962, 5611.775528978795, 5658.377578466366, 5676.914846277309, 5692.800751973744, 5704.11586204139, 6691.698873550702, 6704.731810727516, 6771.187457505131, 6772.288909664611, 6777.830554236183, 6319.557630965788, 6347.809565713036, 6448.580842245239, 6461.8061458156335, 6487.643179625166, 6617.43751781104, 6732.932670673426, 6752.831179220559, 6771.322867713189, 6781.491388146008, 6340.9365906340345, 6383.521235907233, 6385.169927909342, 6390.0, 6406.935930640634, 6245.531585131224, 6329.398707122816, 6333.113364129118, 6423.935760642334, 6441.549091563733, 6161.876762464815, 6244.531660125418, 6249.718762655601, 6262.624242545462, 6269.247690277196, 6037.366076562073, 6223.3465486125115, 6235.0, 6256.593321434092, 6363.5863668861375, 6095.1466794647895, 6118.040554665315, 6123.953766440777, 6189.257289125334, 6234.657093859882, 6201.844953876189, 6240.812775616739, 6269.435750782269, 6272.498200143887, 6317.989121740499, 6220.502359811295, 6224.035274532454, 6225.844353891189, 6237.688115594111, 6270.529710271657], "value": 5924.560484578581, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.4361407750016, 548.550188845147, 557.6124593407578, 585.475998980912, 615.1388056720593, 36065.81967090164, 39648.80175599122, 39765.801170994106, 39833.8008309958, 39880.803575892736, 41307.58692413075, 41479.58520414795, 41624.79187604058, 41851.372229416585, 42129.7893510532, 9541.809163816702, 9609.567569459392, 9614.56734446948, 9666.661666841663, 9711.271654625896, 9637.373570717917, 9841.803163936716, 9895.752606184868, 9898.307118501707, 9913.15738162257, 9860.11258986691, 9866.260030497706, 9889.703308900744, 9913.008699130065, 9934.701958941207, 9843.606255749797, 9897.257705672104, 9913.603455861758, 9955.253355998293, 9974.351667141613, 9653.855192172123, 9711.0, 9757.609695612167, 9760.755981100458, 9767.902320976771, 40026.79986600077, 40124.799376003226, 40193.19613607741, 40444.19111617751, 40848.97877553055, 2833.195136814559, 3177.2215807127172, 3367.9831600842085, 3495.755297129202, 3537.2218112015316, 26536.734632653814, 26765.0, 26967.32581685454, 27254.727452725416, 28163.29591760202, 2225.6105181593157, 2344.2146880794953, 2706.553418685934, 2835.333696581302, 2883.927901802451, 310966.0, 311933.44033279916, 313543.0, 314237.4288128568, 315912.8408715929, 37046.62953370486, 37839.243215135546, 37854.81072594619, 64318.0, 64743.0, 36333.8183309087, 36392.636073638925, 36656.63343366532, 36661.81669091638, 36713.449298260544, 13455.730885382238, 14607.634809129644, 16353.67292654164, 16571.0, 16583.91708041476, 11639.941800290944, 13431.194128352136, 13746.587602371945, 13909.234992075331, 13992.0, 8402.663893444316, 8465.068842427328, 8476.364272679573, 8533.701320453754, 8566.657333706582, 3279.917627183024, 3442.6385229550538, 3550.6981906538235, 3620.5293311869814, 3639.362286970874, 927.5315965437411, 989.5052473763119, 1016.4765145949842, 1118.6028959719345, 1124.4771181400688, 25305.18454689084, 30205.69794302029, 30590.84704576463, 30926.53610195849, 31281.68718312833, 1069.896241939732, 1144.8282757586428, 1190.9047276217882, 1262.7348256865978, 1290.451558087809, 12307.0, 14513.0, 14681.77977330341, 14824.184669843262, 15094.849051509344, 425900.0, 493482.0651793436, 503899.48050259514, 504050.0, 513182.0, 58362.708186458796, 58407.70796145992, 58470.12294815581, 58955.11567326493, 58961.41038589559, 1565.4051460445185, 1576.2670358283453, 1582.8258891521923, 1587.1112177180817, 1597.416942815887, 25320.113796017053, 29290.267743306587, 29857.402851943272, 30296.394072118874, 30393.392132157674, 52142.435726928255, 52940.73529632327, 53191.4680853202, 53579.73210133924, 53857.46142538524, 494541.0, 494765.0, 496867.0, 497777.0, 498008.0, 25732.970681172545, 26796.732032679425, 26821.865890670422, 26940.191794246202, 26984.730152698223, 43072.78463607787, 44396.334054988554, 44634.3304850421, 44960.32559511544, 46568.767156164, 38657.42013869851, 39055.21889562136, 39737.60262397339, 39809.2038159241, 40294.79852600718, 36282.637173627925, 36339.091522712144, 36778.81610592037, 36875.26249474942, 37076.0, 35860.641393586775, 35881.64118358783, 35912.46561184708, 36364.636353636124, 37882.24235515329, 31686.366272674877, 32502.34995300128, 33166.0, 33358.49962250617, 33480.66519334873, 25340.239792806246, 25368.619470708323, 25458.872705636353, 25463.10143367058, 25603.0], "value": 18252.92620443509, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.60765569357255, 371.53001453161744, 403.18355330455825, 411.174025690946, 414.08900419078014, 16091.436799712012, 17406.564835879108, 20552.794472055273, 21365.931703414804, 21369.786302136974, 18014.81985180148, 18250.726239106392, 21334.786652133513, 21629.78370216301, 21988.560228795413, 5799.739011744482, 5824.621399609023, 5994.07091900756, 6052.878942421149, 6081.604695694788, 5936.228290322274, 6035.60768550045, 6047.546434017444, 6055.909161362583, 6083.026715725485, 5701.486866182043, 5966.552508561854, 5969.283685957691, 5974.193483879664, 6002.759889604411, 5775.624584402042, 5776.249087618604, 5862.472377486026, 5886.352501224862, 5930.822075337746, 5093.2105523643895, 5106.923396149061, 5161.66449180802, 5173.405058418292, 5197.506236907488, 24918.252452426455, 25968.480630387476, 26353.73646263532, 26574.0, 26838.5974210387, 1618.441637635014, 2192.1560199323376, 2217.6119179143584, 2230.620794464945, 2433.197044975154, 10292.691219263434, 10299.588016479333, 11918.880811191864, 12079.094067944852, 15040.247987600686, 1752.2990803678504, 1778.6976214043643, 1838.3014454507336, 1843.9907800460912, 1932.391296741522, 108419.45790270998, 111669.0, 112004.43997779959, 115340.0, 117431.0, 9230.953845230732, 9608.27937904646, 11698.122640801974, 11714.297142171497, 11954.76090478203, 15140.848591513944, 15155.166465844484, 15182.013169144191, 15204.16377099248, 15227.314770835339, 9109.498977556166, 9146.2225710814, 9192.448453092837, 9381.5309234538, 9390.718278451657, 9417.576209070608, 9436.386634868712, 9444.244460443148, 9483.33616646842, 9581.041895810364, 4631.930521042187, 4719.268513380432, 4740.928886066712, 4753.667243292936, 4776.95223047772, 1859.711744679577, 1993.6212119697502, 2069.286096296775, 2073.4919944613366, 2078.3349328214827, 894.6466145872344, 1012.4178597306578, 1034.3897100710617, 1044.253358848427, 1073.8335557988523, 18794.624107518048, 19491.610167796563, 20180.0, 20385.388438346872, 20438.69341959872, 959.7792507723262, 1011.1910471622673, 1019.3119644240109, 1019.3323373190572, 1058.692979036071, 10434.530446129942, 10728.463576821285, 10765.78468430627, 10774.24580279373, 10949.0, 566176.0, 648965.0, 662548.0, 665281.0, 670886.0, 114874.0, 117080.82919170869, 118384.0, 120055.0, 120978.0, 1032.0762917189224, 1034.2450011491653, 1040.0743338428804, 1049.8687664041995, 1053.031211285619, 16364.34542618282, 16436.260368283696, 17499.0, 17612.823871761117, 17662.823371766117, 48479.757601213176, 50630.24054639257, 51045.744771277394, 51863.0, 52512.47487525076, 75623.48753025019, 75727.0, 76179.61910190636, 76391.61804190943, 77356.61321693356, 6727.461803055841, 7819.408427474233, 8106.310963567927, 8141.348692104736, 8302.916970830214, 11056.391898445663, 12018.158728888893, 12233.938830305791, 12595.93702031484, 12736.0, 10411.94794026025, 10753.784924301626, 10853.294535855144, 10856.13150947938, 10914.836277455686, 9413.29400294967, 10530.684079477322, 10605.204609654462, 10820.837687434538, 10895.836562451728, 10701.464926753786, 10855.945720271347, 11152.0, 11160.162987775788, 11251.831222531833, 8102.0, 8110.513369197867, 8183.95908020456, 8222.958885205775, 8379.622916968872, 9376.906230937604, 10551.94724026375, 10732.14142868553, 11335.206535542433, 11337.376444295312], "value": 9589.375080048665, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1633.0446688687118, 1642.802863656361, 1890.2439024390242, 1964.950876228094, 2017.656998310287, 8375.036870759865, 9069.591868365922, 9069.954650226757, 9308.115729005742, 9340.3461757677, 9082.81834363314, 9099.272058235325, 9129.771755706111, 9188.8621670675, 9198.356115071947, 2529.759672831078, 2541.4535874786916, 2543.326018605071, 2545.6054311581734, 2569.882101285937, 2502.9249122526353, 2552.7702506774385, 2564.7307032761573, 2574.729653386386, 2580.161447529551, 2520.5337012652626, 2542.224621490445, 2567.101514469939, 2592.338953566838, 2597.5194589001094, 2553.8467691938545, 2555.821092523524, 2578.845269283849, 2583.2250324902548, 2583.8320509167033, 2538.733432989528, 2564.4614630927526, 2587.792976561889, 2589.7669209771025, 2590.3912580543556, 7516.361109305715, 7780.988471498726, 9232.353735238536, 9307.16235538798, 9308.0, 5497.945020549823, 5599.272094627713, 5680.091185410356, 5730.283714535642, 5822.214001109838, 3335.0, 3479.5128681984543, 3501.8774342897877, 3590.7486475946694, 3735.1595890924323, 952.7951490429522, 1069.8074346617607, 1072.2762135558467, 1072.4584085037006, 1073.6671631794168, 12319.753604927851, 12467.93766031173, 12498.312592807391, 12508.937455312665, 12523.937380313131, 5006.549410553068, 5011.0, 5119.769610367543, 5137.332146820964, 5178.741062946913, 10321.0, 10350.844737328945, 10571.0, 10580.576776928836, 10594.993475619804, 5740.741666625012, 5763.711814409263, 5773.0, 5777.768889244468, 5782.566307526952, 4646.79089440976, 5057.140286151363, 5170.1986192140275, 5188.688678679291, 5208.635395522353, 3579.391503444421, 4211.536730959592, 4268.658507319407, 4320.935185972213, 4349.739015659071, 1393.4495874129864, 1398.3637444962517, 1429.8713115819626, 1444.1479527079073, 1444.248990524921, 806.9112397636255, 830.4062595244429, 965.9178969787647, 976.2336565795816, 983.4246965525105, 5981.5214782817275, 6004.42957918997, 6039.063945088518, 6097.603655762361, 6230.376962303824, 933.4306073295285, 963.4412041016334, 996.8056229035413, 1002.8946960569035, 1008.7730260691286, 3987.501562304712, 4024.6176613221696, 4051.6961227908023, 4066.755994640331, 4085.673146148301, 10726.0, 10988.835167472495, 11121.888781112248, 11141.498632561392, 11325.037371823488, 11013.063889569316, 11083.334999900031, 11109.83335249972, 11165.944170279097, 11269.0, 7633.809154771176, 7763.262490063435, 8619.1811777881, 8662.133786621287, 8667.783305417415, 5989.760409583568, 6006.519478441627, 6112.327643959072, 6112.816615501542, 6174.845628859135, 10144.594216231268, 10209.693709188736, 10336.741581460523, 10359.792804144026, 10365.274430789772, 10073.0, 10338.0, 10550.366977981346, 10585.576576936835, 10726.946365268124, 5997.610155339889, 7595.5822429766895, 7832.37341012729, 7851.685932562634, 7854.4894581851995, 7055.541389809646, 8430.494170349799, 8591.140885911358, 8662.436941598777, 8694.478331300143, 6433.935660643334, 7470.738524151629, 7632.084149902047, 7663.69345226207, 7671.923280767121, 6861.55399899005, 6953.0, 7446.515976461513, 7514.0, 7557.735479258419, 7195.964020179866, 7247.673854676657, 7280.381167600814, 7294.63526823646, 7325.890111648223, 4995.475475075064, 5011.599072074298, 5076.695398276115, 5090.287359769709, 5096.0827051131155, 5085.0, 5127.1540195867265, 5127.923081153711, 5214.217867319932, 5360.195970604441], "value": 4792.86585014149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.14283576878967, 337.2581211458863, 338.0517647997367, 344.5744505535664, 346.5650608486349, 6819.5226334156505, 6899.586024838513, 6905.758298459555, 7004.474664400172, 7024.192217894937, 4864.586510146633, 6904.2750511196355, 6905.136857892763, 6941.1670599528, 6949.374556289933, 5027.874303142433, 5134.666246693953, 5138.460461651529, 5141.074606570815, 5160.793568257265, 5142.717150556718, 5144.974275128619, 5147.588192944574, 5149.0731668299695, 5187.247849061884, 5057.822976195834, 5090.389153301609, 5099.770510327045, 5103.336566246383, 5118.616103792212, 3690.3910854708943, 4940.456475636326, 4946.72792996385, 5038.874028149289, 5093.032323858473, 4302.139572085595, 4352.542982986773, 4354.978225108885, 4355.738655680638, 4358.411614432042, 6652.101966234545, 6665.233498147727, 6697.7655782047395, 6704.0, 6732.697028633724, 5284.260203571503, 5923.763049478016, 6038.3659715729655, 6039.124326972608, 6042.516598672096, 5607.8878422431735, 7273.563586184846, 7386.269933683509, 7402.148752893432, 7434.405247580181, 4691.366665500182, 4874.098291816025, 4875.7074575525585, 4876.171050921352, 4894.755262236874, 6349.714262858182, 7888.56612886291, 7931.72238971639, 7946.404019698546, 7985.441019128663, 4988.201887697951, 4988.5260900214425, 4989.575886049726, 4995.375578052744, 5000.024995125988, 5094.694318340911, 5097.158968770112, 5100.296842673389, 5101.132807422747, 5119.822440838628, 6003.0695242237525, 6013.669248191304, 6018.789342372996, 6025.427584379477, 6025.6685882276015, 5960.552958528127, 7198.208197098315, 7487.775366739006, 7493.66278517468, 7525.397968162534, 1736.036499742655, 1755.8507526860105, 1764.700000999833, 1765.2321240260528, 1773.6364045370667, 1063.5692544519482, 1124.8031594470935, 1125.0999200639455, 1148.190525679394, 1153.26191237608, 6209.472194863397, 7119.07452031243, 7249.275072492814, 7262.709491620381, 7265.309795569412, 5460.645058071213, 7199.1361036675935, 7845.254700803414, 7853.057633084067, 7875.921240787633, 7112.324329188718, 7231.421486281085, 7236.891446628305, 7239.312265334785, 7240.565566066053, 3966.960330396717, 4096.774677392772, 4123.876283711494, 4147.564505726916, 4148.522919864255, 6571.2771595124495, 8193.09875913649, 8234.094249632535, 8239.299659528888, 8252.669893204205, 6550.6069635822005, 7920.0, 8050.718224862102, 8057.5165490070785, 8076.273135417723, 6559.311272316433, 8202.712905048294, 8218.096009438957, 8220.83558328842, 8225.876611850827, 6262.405071518198, 7568.281013303727, 7770.261825126604, 7874.606269686378, 7877.606119693878, 6145.354737752472, 7649.273319034683, 7649.579273140031, 7667.808304792425, 7670.7315243966195, 6536.379043990813, 8212.917870821215, 8230.506169629842, 8238.299744521782, 8266.875996859932, 4827.927581086216, 4867.367242258625, 4874.756262186947, 4885.364902562644, 4886.657933944732, 7486.625668716433, 7619.238076192337, 7744.0319960005, 7747.728829491166, 7770.45606807518, 7440.851182976418, 7451.031365922396, 7458.888116678146, 7462.0, 7497.737579184703, 6201.906971395523, 7451.44114191427, 7469.365103966006, 7481.551106933602, 7486.737964171446, 7016.473764467583, 7060.223375428802, 7257.709691612276, 7292.197858235696, 7294.598797066213, 7471.140818805907, 7504.549727016397, 7505.099388073248, 7520.924790752241, 7523.210062943313, 7064.894026589708, 7157.498975071695, 7272.636368181676, 7347.33873951347, 7348.853022939618], "value": 5399.3429127864865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.087342960433, 706.2513735440431, 729.821193807517, 783.5600968801233, 792.4136139256948, 15411.845881541181, 15488.0, 15650.982686125408, 15703.764443533357, 15727.056376617411, 14378.49675261366, 14690.192039437827, 14754.188519631416, 14755.631109222248, 14807.703845923103, 793.4723408933053, 922.0502882031518, 941.1717688434203, 944.1596978688972, 972.7276362618478, 936.3071327217843, 959.9760005999871, 973.7370909854335, 974.8586454964026, 977.6333874796951, 984.4044353166339, 985.0297457004845, 986.5264672956949, 994.9552270147825, 1036.9533370998286, 886.8315020146216, 969.7866469376726, 981.3915372469079, 986.8026394721048, 1012.8278192707257, 735.9264073592651, 751.1887161865172, 761.6306091545596, 767.9923200768033, 777.3975169243824, 14677.48628797987, 14869.851301487062, 14872.405103795834, 14874.702505949928, 15010.924945375313, 13083.084184107116, 13194.340282985908, 13291.601251962456, 13351.132176408502, 13365.465381384733, 10261.79476410475, 10293.485325733758, 10399.06408423238, 10432.269741118125, 10632.787344253149, 3552.946705799415, 3575.213453040327, 3592.8203589820664, 3627.8004709740953, 3665.7433979621437, 55238.447615523735, 78509.0, 88999.0, 89047.0, 89439.55280223557, 9746.75633109178, 9787.412755234709, 9831.86933502642, 9852.0, 9980.950095249478, 17677.911610441864, 21907.67138492924, 22240.0, 22253.66619500709, 22406.551868962855, 7686.654100565488, 7809.882851757228, 7830.8433831323055, 7926.643301051351, 7999.760007199793, 3553.271579326232, 4105.651019663303, 4202.978985105116, 4329.264025115738, 4376.081022985145, 2959.8964036258626, 3332.5336851785137, 3729.5710993236125, 3766.8304926278383, 3769.359208934488, 671.4628297362091, 675.5642610516189, 679.9490038247151, 691.0877641513155, 692.3906961873519, 534.7086785413184, 543.7580276776796, 600.6366148480193, 603.2037710222464, 609.1958614628647, 7114.39527640146, 8124.7562573122905, 8245.340372770164, 8306.54314012735, 8349.874751878726, 541.388231298638, 555.5860883641712, 582.1839820196209, 591.8668299632549, 598.4045874354957, 3886.358750806142, 3919.7844118573753, 3941.467901833273, 3955.6835453163676, 4104.979475102665, 91280.0, 95069.0, 95415.0, 95497.04502954881, 95585.5220723892, 78167.43665126666, 79916.60041699755, 80350.0, 80523.7921431179, 81698.59150704327, 71438.57122857514, 72392.0, 72592.2740772596, 73671.63164184253, 74147.14632134132, 7794.2595453434105, 7806.687732490636, 7860.489068210548, 7913.44605877583, 7927.563983980936, 35398.469022964164, 48229.0, 48229.75885120552, 48640.0, 51449.0, 68624.6568767153, 69196.30803692101, 69350.65324673345, 70540.58918821698, 71068.28931710617, 9899.851502227617, 9987.500624968578, 10005.249606279413, 10164.796704066026, 10337.17302615804, 10879.945600271947, 10987.61543345979, 11009.889901100887, 11428.94285528567, 11472.88527114718, 10238.232132589937, 10284.331518451278, 10311.0, 10478.528466218886, 10867.619633312795, 10139.340942838691, 10400.58397664085, 10614.628488002883, 10762.08522275584, 11175.608853690082, 10146.594136234467, 10212.131968782736, 10212.642557510748, 10444.791104177722, 10644.680659580225, 8860.0, 8880.644774208959, 9094.499802510925, 9131.908680913106, 9266.166045055978, 8922.955385223033, 9006.909930900607, 9049.095090490899, 9074.863877041718, 9162.175404213653], "value": 6908.770028453398, "unit": "score"}], "name": "dromaeo_css", "value": 7551.348482565966, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 121.0, 110.0, 117.0, 118.0, 134.0, 118.0, 117.0, 122.0, 125.0], "value": 119.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 142.0, 158.0, 120.0, 138.0, 123.0, 156.0, 195.0, 154.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 181.0, 262.0, 276.0, 198.0, 202.0, 257.0, 239.0, 203.0, 199.0], "value": 224.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 86.0, 143.0, 64.0, 81.0, 84.0, 93.0, 125.0, 57.0], "value": 86.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 121.0, 80.0, 84.0, 82.0, 121.0, 80.0, 81.0, 129.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 92.0, 79.0, 136.0, 126.0, 93.0, 89.0, 134.0, 92.0], "value": 111.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 93.0, 142.0, 150.0, 150.0, 110.0, 154.0, 149.0, 97.0, 97.0], "value": 124.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 93.0, 89.0, 89.0, 116.0, 127.0, 91.0, 92.0, 92.0, 117.0], "value": 100.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 70.0, 98.0, 98.0, 98.0, 96.0, 66.0, 79.0, 63.0, 60.0], "value": 78.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 61.0, 86.0, 95.0, 112.0, 101.0, 67.0, 68.0, 66.0, 65.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 82.0, 84.0, 82.0, 78.0, 83.0, 80.0, 81.0, 84.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 125.0, 123.0, 126.0, 124.0, 126.0, 126.0, 122.0, 147.0, 179.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 178.0, 160.0, 220.0, 180.0, 196.0, 217.0, 225.0, 181.0, 177.0], "value": 190.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 103.0, 99.0, 66.0, 68.0, 68.0, 68.0, 67.0, 66.0, 69.0], "value": 76.4, "unit": "score"}], "name": "kraken", "value": 1645.4999999999998, "alertThreshold": 2.0}]} 19:23:17 INFO - Return code: 0 19:23:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:23:17 ERROR - # TBPL SUCCESS # 19:23:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:23:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:23:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:23:17 INFO - 2016-07-07 19:23:17.980 screenresolution[1689:10501] starting screenresolution argv=screenresolution get 19:23:17 INFO - 2016-07-07 19:23:17.983 screenresolution[1689:10501] Display 0: 1600x1200x32@60 19:23:17 INFO - 2016-07-07 19:23:17.989 screenresolution[1690:10504] starting screenresolution argv=screenresolution list 19:23:17 INFO - Available Modes on Display 0 19:23:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:23:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:23:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:23:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:23:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:23:18 INFO - Intel Iris: 19:23:18 INFO - Chipset Model: Intel Iris 19:23:18 INFO - Type: GPU 19:23:18 INFO - Bus: Built-In 19:23:18 INFO - VRAM (Dynamic, Max): 1536 MB 19:23:18 INFO - Vendor: Intel (0x8086) 19:23:18 INFO - Device ID: 0x0a2e 19:23:18 INFO - Revision ID: 0x0009 19:23:18 INFO - Displays: 19:23:18 INFO - Display: 19:23:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:23:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:23:18 INFO - Display Serial Number: 1600x1200 60 19:23:18 INFO - Main Display: Yes 19:23:18 INFO - Mirror: Off 19:23:18 INFO - Online: Yes 19:23:18 INFO - Rotation: Supported 19:23:18 INFO - Return code: 0 19:23:18 INFO - Running post-action listener: _resource_record_post_action 19:23:18 INFO - Running post-run listener: _resource_record_post_run 19:23:19 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 36749824; Write bytes: 498021376; Read time: 238; Write time: 1578 19:23:19 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189258240; Write bytes: 187582464; Read time: 17241; Write time: 402 19:23:19 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 34935296; Write bytes: 299650048; Read time: 221; Write time: 1140 19:23:19 INFO - Running post-run listener: _upload_blobber_files 19:23:19 INFO - Blob upload gear active. 19:23:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:23:19 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 19:23:19 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'] 19:23:19 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 19:23:19 INFO - (blobuploader) - INFO - Open directory for files ... 19:23:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:23:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:23:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:20 INFO - (blobuploader) - INFO - Done attempting. 19:23:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:23:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:23:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:21 INFO - (blobuploader) - INFO - Done attempting. 19:23:21 INFO - (blobuploader) - INFO - Iteration through files over. 19:23:21 INFO - Return code: 0 19:23:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:23:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:23:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6b0fccd756226dfdfc8cc5a9a85e429ea811013ebd466e18a71e7aadde2afa27016176e805646a3705d363b98be967766fc2f052d5cd31aedc0c854e88c76f49", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a884c9e76d14a649aa048475d825f3676516934f3401c66e0e72737eac8347bfb5644b7068626299aa02ca1db720cecb5ab4d57d6487185296d82236d88c103"} 19:23:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:23:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:23:21 INFO - Contents: 19:23:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6b0fccd756226dfdfc8cc5a9a85e429ea811013ebd466e18a71e7aadde2afa27016176e805646a3705d363b98be967766fc2f052d5cd31aedc0c854e88c76f49", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a884c9e76d14a649aa048475d825f3676516934f3401c66e0e72737eac8347bfb5644b7068626299aa02ca1db720cecb5ab4d57d6487185296d82236d88c103"} 19:23:21 INFO - Running post-run listener: copy_logs_to_upload_dir 19:23:21 INFO - Copying logs to upload dir... 19:23:21 INFO - mkdir: /builds/slave/test/build/upload/logs 19:23:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.960657 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-07 19:23:21.495149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 19:23:21.499083) ========= 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.ZwBTsS271R/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.AMOXDjQoGN/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6b0fccd756226dfdfc8cc5a9a85e429ea811013ebd466e18a71e7aadde2afa27016176e805646a3705d363b98be967766fc2f052d5cd31aedc0c854e88c76f49", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a884c9e76d14a649aa048475d825f3676516934f3401c66e0e72737eac8347bfb5644b7068626299aa02ca1db720cecb5ab4d57d6487185296d82236d88c103"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011129 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6b0fccd756226dfdfc8cc5a9a85e429ea811013ebd466e18a71e7aadde2afa27016176e805646a3705d363b98be967766fc2f052d5cd31aedc0c854e88c76f49", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a884c9e76d14a649aa048475d825f3676516934f3401c66e0e72737eac8347bfb5644b7068626299aa02ca1db720cecb5ab4d57d6487185296d82236d88c103"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 19:23:21.532270) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:23:21.532591) ========= 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.ZwBTsS271R/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.AMOXDjQoGN/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005177 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:23:21.581465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 19:23:21.581783) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 19:23:21.582095) ========= ========= Total master_lag: 0.18 =========