builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0278 starttime: 1468699741.04 results: success (0) buildid: 20160714034658 builduid: 8f9438d5bd224c6d8ec9a97285402187 revision: 2ba3feb910fb31f5fb3df3528b2991b3a37b05cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:01.043860) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:01.044686) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:01.044995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:01.320364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:01.320660) ========= 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.QrspE2RtRF/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.eYiQUoFNjC/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-16 13:09:01-- 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% 18.6M=0.001s 2016-07-16 13:09:01 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146455 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:01.512804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:01.513091) ========= 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.QrspE2RtRF/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.eYiQUoFNjC/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.027016 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:01.623673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-16 13:09:01.624126) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2ba3feb910fb31f5fb3df3528b2991b3a37b05cf --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 2ba3feb910fb31f5fb3df3528b2991b3a37b05cf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QrspE2RtRF/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.eYiQUoFNjC/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-16 13:09:01,712 truncating revision to first 12 chars 2016-07-16 13:09:01,712 Setting DEBUG logging. 2016-07-16 13:09:01,712 attempt 1/10 2016-07-16 13:09:01,712 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2ba3feb910fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 13:09:02,737 unpacking tar archive at: mozilla-beta-2ba3feb910fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.282749 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-16 13:09:02.936279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:02.936608) ========= script_repo_revision: 2ba3feb910fb31f5fb3df3528b2991b3a37b05cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:02.937001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:02.937265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 13:09:02.958444) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-07-16 13:09:02.958819) ========= /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.QrspE2RtRF/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.eYiQUoFNjC/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:09:03 INFO - MultiFileLogger online at 20160716 13:09:03 in /builds/slave/test 13:09:03 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 13:09:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:09:03 INFO - {'append_to_log': False, 13:09:03 INFO - 'base_work_dir': '/builds/slave/test', 13:09:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:09:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:09:03 INFO - 'branch': 'Mozilla-Beta', 13:09:03 INFO - 'buildbot_json_path': 'buildprops.json', 13:09:03 INFO - 'config_files': ('talos/mac_config.py',), 13:09:03 INFO - 'default_actions': ('clobber', 13:09:03 INFO - 'read-buildbot-config', 13:09:03 INFO - 'download-and-extract', 13:09:03 INFO - 'populate-webroot', 13:09:03 INFO - 'create-virtualenv', 13:09:03 INFO - 'install', 13:09:03 INFO - 'run-tests'), 13:09:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:09:03 INFO - 'download_minidump_stackwalk': True, 13:09:03 INFO - 'download_symbols': 'ondemand', 13:09:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:09:03 INFO - 'tooltool.py': '/tools/tooltool.py', 13:09:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:09:03 INFO - '/tools/misc-python/virtualenv.py')}, 13:09:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:09:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:09:03 INFO - 'installer_path': 'installer.exe', 13:09:03 INFO - 'log_level': 'info', 13:09:03 INFO - 'log_name': 'talos', 13:09:03 INFO - 'log_to_console': True, 13:09:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:09:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:09:03 INFO - 'opt_config_files': (), 13:09:03 INFO - 'pip_index': False, 13:09:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:09:03 INFO - 'cmd': ('bash', 13:09:03 INFO - '-c', 13:09:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:09:03 INFO - 'enabled': True, 13:09:03 INFO - 'halt_on_failure': False, 13:09:03 INFO - 'name': 'check_screen_resolution'},), 13:09:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:09:03 INFO - 'cmd': ('bash', 13:09:03 INFO - '-c', 13:09:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:09:03 INFO - 'enabled': True, 13:09:03 INFO - 'halt_on_failure': False, 13:09:03 INFO - 'name': 'check_screen_resolution'},), 13:09:03 INFO - 'run_cmd_checks_enabled': True, 13:09:03 INFO - 'sps_profile': False, 13:09:03 INFO - 'sps_profile_interval': 0, 13:09:03 INFO - 'suite': 'dromaeojs-e10s', 13:09:03 INFO - 'system_bits': '32', 13:09:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:09:03 INFO - 'title': 't-yosemite-r7-0278', 13:09:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:09:03 INFO - 'use_talos_json': True, 13:09:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:09:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:09:03 INFO - 'work_dir': 'build'} 13:09:03 INFO - ##### 13:09:03 INFO - ##### Running clobber step. 13:09:03 INFO - ##### 13:09:03 INFO - Running pre-action listener: _resource_record_pre_action 13:09:03 INFO - Running main action method: clobber 13:09:03 INFO - rmtree: /builds/slave/test/build 13:09:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:09:05 INFO - Running post-action listener: _resource_record_post_action 13:09:05 INFO - ##### 13:09:05 INFO - ##### Running read-buildbot-config step. 13:09:05 INFO - ##### 13:09:05 INFO - Running pre-action listener: _resource_record_pre_action 13:09:05 INFO - Running main action method: read_buildbot_config 13:09:05 INFO - Using buildbot properties: 13:09:05 INFO - { 13:09:05 INFO - "project": "", 13:09:05 INFO - "product": "firefox", 13:09:05 INFO - "script_repo_revision": "production", 13:09:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:09:05 INFO - "repository": "", 13:09:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:09:05 INFO - "buildid": "20160714034658", 13:09:05 INFO - "pgo_build": "False", 13:09:05 INFO - "basedir": "/builds/slave/test", 13:09:05 INFO - "buildnumber": 45, 13:09:05 INFO - "slavename": "t-yosemite-r7-0278", 13:09:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:09:05 INFO - "platform": "yosemite_r7", 13:09:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:09:05 INFO - "branch": "mozilla-beta", 13:09:05 INFO - "repo_path": "releases/mozilla-beta", 13:09:05 INFO - "revision": "2ba3feb910fb31f5fb3df3528b2991b3a37b05cf", 13:09:05 INFO - "stage_platform": "macosx64", 13:09:05 INFO - "builduid": "8f9438d5bd224c6d8ec9a97285402187", 13:09:05 INFO - "slavebuilddir": "test" 13:09:05 INFO - } 13:09:05 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.dmg. 13:09:05 INFO - Running post-action listener: _resource_record_post_action 13:09:05 INFO - ##### 13:09:05 INFO - ##### Running download-and-extract step. 13:09:05 INFO - ##### 13:09:05 INFO - Running pre-action listener: _resource_record_pre_action 13:09:05 INFO - Running main action method: download_and_extract 13:09:05 INFO - mkdir: /builds/slave/test/build/tests 13:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.test_packages.json 13:09:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 13:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/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 13:09:05 INFO - Downloaded 1165 bytes. 13:09:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 13:09:05 INFO - Using the following test package requirements: 13:09:05 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:09:05 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:09:05 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 13:09:05 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:09:05 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 13:09:05 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:09:05 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:09:05 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 13:09:05 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:09:05 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:09:05 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 13:09:05 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:09:05 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 13:09:05 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:09:05 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 13:09:05 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:09:05 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 13:09:05 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 13:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.common.tests.zip 13:09:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 13:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/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 13:09:09 INFO - Downloaded 18314851 bytes. 13:09:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:09:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:09:12 INFO - Return code: 0 13:09:12 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 13:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:12 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.common.tests.zip 13:09:12 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 13:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/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 13:09:12 INFO - Downloaded 18314851 bytes. 13:09:12 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'] 13:09:12 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 13:09:16 INFO - Return code: 0 13:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:16 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.talos.tests.zip 13:09:16 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 13:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/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 13:09:18 INFO - Downloaded 10840145 bytes. 13:09:18 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'] 13:09:18 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 13:09:18 INFO - Return code: 0 13:09: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')]} 13:09:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.dmg 13:09:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 13:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 13:09:27 INFO - Downloaded 86189657 bytes. 13:09:27 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.dmg 13:09:27 INFO - mkdir: /builds/slave/test/properties 13:09:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:09:27 INFO - Writing to file /builds/slave/test/properties/build_url 13:09:27 INFO - Contents: 13:09:27 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.dmg 13:09:28 INFO - Running post-action listener: _resource_record_post_action 13:09:28 INFO - Running post-action listener: set_extra_try_arguments 13:09:28 INFO - ##### 13:09:28 INFO - ##### Running populate-webroot step. 13:09:28 INFO - ##### 13:09:28 INFO - Running pre-action listener: _resource_record_pre_action 13:09:28 INFO - Running main action method: populate_webroot 13:09:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:09:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:09:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:09:28 INFO - '--tppagecycles', 13:09:28 INFO - '7'], 13:09:28 INFO - 'tests': ['tsvgm']}}, 13:09:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:09:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:09:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:09:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:09:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:09:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:09:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:28 INFO - 'talos_options': ['--disable-e10s'], 13:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:28 INFO - 'talos_options': ['--disable-e10s'], 13:09:28 INFO - 'tests': ['damp', 'tps']}, 13:09:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:28 INFO - 'tests': ['damp', 'tps']}, 13:09:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:09:28 INFO - 'tests': ['dromaeo_dom']}, 13:09:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:09:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:09:28 INFO - 'tests': ['a11yr', 13:09:28 INFO - 'ts_paint', 13:09:28 INFO - 'tpaint', 13:09:28 INFO - 'sessionrestore', 13:09:28 INFO - 'sessionrestore_no_auto_restore', 13:09:28 INFO - 'tabpaint']}, 13:09:28 INFO - 'other-e10s': {'tests': ['a11yr', 13:09:28 INFO - 'ts_paint', 13:09:28 INFO - 'tpaint', 13:09:28 INFO - 'sessionrestore', 13:09:28 INFO - 'sessionrestore_no_auto_restore', 13:09:28 INFO - 'tabpaint']}, 13:09:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:09:28 INFO - 'ts_paint', 13:09:28 INFO - 'tpaint', 13:09:28 INFO - 'sessionrestore', 13:09:28 INFO - 'sessionrestore_no_auto_restore', 13:09:28 INFO - 'tabpaint']}, 13:09:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:09:28 INFO - 'ts_paint', 13:09:28 INFO - 'tpaint', 13:09:28 INFO - 'sessionrestore', 13:09:28 INFO - 'sessionrestore_no_auto_restore', 13:09:28 INFO - 'tabpaint']}, 13:09:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:09:28 INFO - 'tests': ['a11yr', 13:09:28 INFO - 'ts_paint', 13:09:28 INFO - 'tpaint', 13:09:28 INFO - 'sessionrestore', 13:09:28 INFO - 'sessionrestore_no_auto_restore', 13:09:28 INFO - 'tabpaint']}, 13:09:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:09:28 INFO - 'tests': ['a11yr', 13:09:28 INFO - 'ts_paint', 13:09:28 INFO - 'tpaint', 13:09:28 INFO - 'sessionrestore', 13:09:28 INFO - 'sessionrestore_no_auto_restore', 13:09:28 INFO - 'tabpaint']}, 13:09:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:09:28 INFO - 'tests': ['tsvgx', 13:09:28 INFO - 'tsvgr_opacity', 13:09:28 INFO - 'tart', 13:09:28 INFO - 'tscrollx', 13:09:28 INFO - 'cart']}, 13:09:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:09:28 INFO - 'tsvgr_opacity', 13:09:28 INFO - 'tart', 13:09:28 INFO - 'tscrollx', 13:09:28 INFO - 'cart']}, 13:09:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:28 INFO - 'talos_options': ['--disable-e10s'], 13:09:28 INFO - 'tests': ['tp5o']}, 13:09:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:28 INFO - 'tests': ['tp5o']}, 13:09:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:28 INFO - 'talos_options': ['--disable-e10s', 13:09:28 INFO - '--xperf_path', 13:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:28 INFO - 'tests': ['tp5n']}, 13:09:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:28 INFO - 'talos_options': ['--xperf_path', 13:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:28 INFO - 'tests': ['tp5n']}}, 13:09:28 INFO - 'talos.zip': {'path': '', 13:09:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:09:28 INFO - Running post-action listener: _resource_record_post_action 13:09:28 INFO - ##### 13:09:28 INFO - ##### Running create-virtualenv step. 13:09:28 INFO - ##### 13:09:28 INFO - Running pre-action listener: _resource_record_pre_action 13:09:28 INFO - Running main action method: create_virtualenv 13:09:28 INFO - Creating virtualenv /builds/slave/test/build/venv 13:09:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:09:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:09:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:09:28 INFO - Using real prefix '/tools/python27' 13:09:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:09:28 INFO - Installing distribute.............................................................................................................................................................................................done. 13:09:31 INFO - Installing pip.................done. 13:09:31 INFO - Return code: 0 13:09:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103636a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103646420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff343ca66a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5e00>, '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 0x10333edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034d0b20>, '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.QrspE2RtRF/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.eYiQUoFNjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QrspE2RtRF/Render', 13:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:31 INFO - 'HOME': '/Users/cltbld', 13:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:31 INFO - 'LOGNAME': 'cltbld', 13:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:31 INFO - 'MOZ_NO_REMOTE': '1', 13:09:31 INFO - 'NO_EM_RESTART': '1', 13:09:31 INFO - 'PAGER': '/bin/cat', 13:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:31 INFO - 'PWD': '/builds/slave/test', 13:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:31 INFO - 'SHELL': '/bin/bash', 13:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYiQUoFNjC/Listeners', 13:09:31 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:31 INFO - 'USER': 'cltbld', 13:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:31 INFO - 'XPC_FLAGS': '0x0', 13:09:31 INFO - 'XPC_SERVICE_NAME': '0', 13:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:09:32 INFO - Cleaning up... 13:09:32 INFO - Return code: 0 13:09:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:32 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 0x103636a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103646420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff343ca66a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5e00>, '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 0x10333edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034d0b20>, '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.QrspE2RtRF/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.eYiQUoFNjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:09:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QrspE2RtRF/Render', 13:09:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:32 INFO - 'HOME': '/Users/cltbld', 13:09:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:32 INFO - 'LOGNAME': 'cltbld', 13:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:32 INFO - 'MOZ_NO_REMOTE': '1', 13:09:32 INFO - 'NO_EM_RESTART': '1', 13:09:32 INFO - 'PAGER': '/bin/cat', 13:09:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:32 INFO - 'PWD': '/builds/slave/test', 13:09:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:32 INFO - 'SHELL': '/bin/bash', 13:09:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYiQUoFNjC/Listeners', 13:09:32 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:09:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:32 INFO - 'USER': 'cltbld', 13:09:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:32 INFO - 'XPC_FLAGS': '0x0', 13:09:32 INFO - 'XPC_SERVICE_NAME': '0', 13:09:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:32 INFO - Downloading/unpacking psutil>=0.7.1 13:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:09:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:35 INFO - Installing collected packages: psutil 13:09:35 INFO - Running setup.py install for psutil 13:09:35 INFO - building 'psutil._psutil_osx' extension 13:09:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:09:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:09:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:09:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:09:36 INFO - building 'psutil._psutil_posix' extension 13:09:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:09:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:09:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:09:36 INFO - ^ 13:09:36 INFO - 1 warning generated. 13:09:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:09:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:36 INFO - Successfully installed psutil 13:09:36 INFO - Cleaning up... 13:09:36 INFO - Return code: 0 13:09:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:36 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 0x103636a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103646420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff343ca66a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5e00>, '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 0x10333edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034d0b20>, '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.QrspE2RtRF/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.eYiQUoFNjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QrspE2RtRF/Render', 13:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:36 INFO - 'HOME': '/Users/cltbld', 13:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:36 INFO - 'LOGNAME': 'cltbld', 13:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:36 INFO - 'MOZ_NO_REMOTE': '1', 13:09:36 INFO - 'NO_EM_RESTART': '1', 13:09:36 INFO - 'PAGER': '/bin/cat', 13:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:36 INFO - 'PWD': '/builds/slave/test', 13:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:36 INFO - 'SHELL': '/bin/bash', 13:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYiQUoFNjC/Listeners', 13:09:36 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:36 INFO - 'USER': 'cltbld', 13:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:36 INFO - 'XPC_FLAGS': '0x0', 13:09:36 INFO - 'XPC_SERVICE_NAME': '0', 13:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:09:39 INFO - Installing collected packages: mozsystemmonitor 13:09:39 INFO - Running setup.py install for mozsystemmonitor 13:09:39 INFO - Successfully installed mozsystemmonitor 13:09:39 INFO - Cleaning up... 13:09:39 INFO - Return code: 0 13:09:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103636a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103646420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff343ca66a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5e00>, '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 0x10333edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034d0b20>, '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.QrspE2RtRF/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.eYiQUoFNjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QrspE2RtRF/Render', 13:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:39 INFO - 'HOME': '/Users/cltbld', 13:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:39 INFO - 'LOGNAME': 'cltbld', 13:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:39 INFO - 'MOZ_NO_REMOTE': '1', 13:09:39 INFO - 'NO_EM_RESTART': '1', 13:09:39 INFO - 'PAGER': '/bin/cat', 13:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:39 INFO - 'PWD': '/builds/slave/test', 13:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:39 INFO - 'SHELL': '/bin/bash', 13:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYiQUoFNjC/Listeners', 13:09:39 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:39 INFO - 'USER': 'cltbld', 13:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:39 INFO - 'XPC_FLAGS': '0x0', 13:09:39 INFO - 'XPC_SERVICE_NAME': '0', 13:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:39 INFO - Downloading/unpacking blobuploader==1.2.4 13:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:42 INFO - Downloading blobuploader-1.2.4.tar.gz 13:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:43 INFO - Downloading docopt-0.6.1.tar.gz 13:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:43 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:43 INFO - Running setup.py install for blobuploader 13:09:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:43 INFO - Running setup.py install for requests 13:09:44 INFO - Running setup.py install for docopt 13:09:44 INFO - Successfully installed blobuploader requests docopt 13:09:44 INFO - Cleaning up... 13:09:44 INFO - Return code: 0 13:09:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:44 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 0x103636a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103646420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff343ca66a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5e00>, '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 0x10333edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034d0b20>, '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.QrspE2RtRF/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.eYiQUoFNjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QrspE2RtRF/Render', 13:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:44 INFO - 'HOME': '/Users/cltbld', 13:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:44 INFO - 'LOGNAME': 'cltbld', 13:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:44 INFO - 'MOZ_NO_REMOTE': '1', 13:09:44 INFO - 'NO_EM_RESTART': '1', 13:09:44 INFO - 'PAGER': '/bin/cat', 13:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:44 INFO - 'PWD': '/builds/slave/test', 13:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:44 INFO - 'SHELL': '/bin/bash', 13:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYiQUoFNjC/Listeners', 13:09:44 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:44 INFO - 'USER': 'cltbld', 13:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:44 INFO - 'XPC_FLAGS': '0x0', 13:09:44 INFO - 'XPC_SERVICE_NAME': '0', 13:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:44 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-uK5hXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:44 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-2xmY59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:44 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Zo1HsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:44 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-0gYs0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:45 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-N7LpAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:45 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-1CV8PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:45 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-3CB4Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:45 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-TEWdA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:45 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-SBfT_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:45 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-iwiJGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:45 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-cLQ8CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:45 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-ik_j_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:45 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-X7JhZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:45 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-F5THB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:46 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-lcJwKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:46 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Gwfyca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:46 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vpb95q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:09:46 INFO - Running setup.py install for manifestparser 13:09:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:09:46 INFO - Running setup.py install for mozcrash 13:09:46 INFO - Running setup.py install for mozdebug 13:09:46 INFO - Running setup.py install for mozdevice 13:09:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:09:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:09:47 INFO - Running setup.py install for mozfile 13:09:47 INFO - Running setup.py install for mozhttpd 13:09:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:09:47 INFO - Running setup.py install for mozinfo 13:09:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:09:47 INFO - Running setup.py install for mozInstall 13:09:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:09:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:09:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:09:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:09:47 INFO - Running setup.py install for mozleak 13:09:47 INFO - Running setup.py install for mozlog 13:09:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:09:47 INFO - Running setup.py install for moznetwork 13:09:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:09:48 INFO - Running setup.py install for mozprocess 13:09:48 INFO - Running setup.py install for mozprofile 13:09:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:09:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:09:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:09:48 INFO - Running setup.py install for mozrunner 13:09:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:09:48 INFO - Running setup.py install for mozscreenshot 13:09:48 INFO - Running setup.py install for moztest 13:09:48 INFO - Running setup.py install for mozversion 13:09:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:09:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:09:48 INFO - Cleaning up... 13:09:48 INFO - Return code: 0 13:09:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 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 0x103636a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103646420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff343ca66a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5e00>, '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 0x10333edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034d0b20>, '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.QrspE2RtRF/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.eYiQUoFNjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QrspE2RtRF/Render', 13:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:48 INFO - 'HOME': '/Users/cltbld', 13:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:48 INFO - 'LOGNAME': 'cltbld', 13:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:48 INFO - 'MOZ_NO_REMOTE': '1', 13:09:48 INFO - 'NO_EM_RESTART': '1', 13:09:48 INFO - 'PAGER': '/bin/cat', 13:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:48 INFO - 'PWD': '/builds/slave/test', 13:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:48 INFO - 'SHELL': '/bin/bash', 13:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYiQUoFNjC/Listeners', 13:09:48 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:48 INFO - 'USER': 'cltbld', 13:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:48 INFO - 'XPC_FLAGS': '0x0', 13:09:48 INFO - 'XPC_SERVICE_NAME': '0', 13:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:49 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-OJcQXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:49 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-LDESRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:49 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-WLerNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:49 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-5kh0xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:49 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-W5zv5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:49 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-IbMmdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:49 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-aQO35j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:49 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-S4e22g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:50 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-WXPT3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:50 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-9eeNNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:50 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Qie5tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:50 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-lhh9wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:50 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-cG3iS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:50 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-quSSrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:50 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-j4PqFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:50 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-qdL3h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:50 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-hX6FBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:09:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:53 INFO - Downloading blessings-1.6.tar.gz 13:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:09:53 INFO - Installing collected packages: blessings 13:09:53 INFO - Running setup.py install for blessings 13:09:53 INFO - Successfully installed blessings 13:09:53 INFO - Cleaning up... 13:09:53 INFO - Return code: 0 13:09:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:54 INFO - Reading from file tmpfile_stdout 13:09:54 INFO - Current package versions: 13:09:54 INFO - blessings == 1.6 13:09:54 INFO - blobuploader == 1.2.4 13:09:54 INFO - docopt == 0.6.1 13:09:54 INFO - manifestparser == 1.1 13:09:54 INFO - mozInstall == 1.12 13:09:54 INFO - mozcrash == 0.17 13:09:54 INFO - mozdebug == 0.1 13:09:54 INFO - mozdevice == 0.48 13:09:54 INFO - mozfile == 1.2 13:09:54 INFO - mozhttpd == 0.7 13:09:54 INFO - mozinfo == 0.9 13:09:54 INFO - mozleak == 0.1 13:09:54 INFO - mozlog == 3.1 13:09:54 INFO - moznetwork == 0.27 13:09:54 INFO - mozprocess == 0.22 13:09:54 INFO - mozprofile == 0.28 13:09:54 INFO - mozrunner == 6.11 13:09:54 INFO - mozscreenshot == 0.1 13:09:54 INFO - mozsystemmonitor == 0.0 13:09:54 INFO - moztest == 0.7 13:09:54 INFO - mozversion == 1.4 13:09:54 INFO - psutil == 3.1.1 13:09:54 INFO - requests == 1.2.3 13:09:54 INFO - wsgiref == 0.1.2 13:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:54 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 0x103636a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103646420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff343ca66a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5e00>, '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 0x10333edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034d0b20>, '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.QrspE2RtRF/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.eYiQUoFNjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:09:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QrspE2RtRF/Render', 13:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:54 INFO - 'HOME': '/Users/cltbld', 13:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:54 INFO - 'LOGNAME': 'cltbld', 13:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:54 INFO - 'MOZ_NO_REMOTE': '1', 13:09:54 INFO - 'NO_EM_RESTART': '1', 13:09:54 INFO - 'PAGER': '/bin/cat', 13:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:54 INFO - 'PWD': '/builds/slave/test', 13:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:54 INFO - 'SHELL': '/bin/bash', 13:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYiQUoFNjC/Listeners', 13:09:54 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:54 INFO - 'USER': 'cltbld', 13:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:54 INFO - 'XPC_FLAGS': '0x0', 13:09:54 INFO - 'XPC_SERVICE_NAME': '0', 13:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:09:54 INFO - Cleaning up... 13:09:54 INFO - Return code: 0 13:09:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:54 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 0x103636a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103646420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff343ca66a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5e00>, '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 0x10333edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034d0b20>, '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.QrspE2RtRF/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.eYiQUoFNjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:09:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QrspE2RtRF/Render', 13:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:54 INFO - 'HOME': '/Users/cltbld', 13:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:54 INFO - 'LOGNAME': 'cltbld', 13:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:54 INFO - 'MOZ_NO_REMOTE': '1', 13:09:54 INFO - 'NO_EM_RESTART': '1', 13:09:54 INFO - 'PAGER': '/bin/cat', 13:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:54 INFO - 'PWD': '/builds/slave/test', 13:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:54 INFO - 'SHELL': '/bin/bash', 13:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYiQUoFNjC/Listeners', 13:09:54 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:54 INFO - 'USER': 'cltbld', 13:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:54 INFO - 'XPC_FLAGS': '0x0', 13:09:54 INFO - 'XPC_SERVICE_NAME': '0', 13:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:54 INFO - Downloading/unpacking jsonschema 13:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:57 INFO - Downloading/unpacking functools32 (from jsonschema) 13:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:57 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:57 INFO - warning: no files found matching '*.txt' 13:09:57 INFO - no previously-included directories found matching 'build' 13:09:57 INFO - no previously-included directories found matching 'dist' 13:09:57 INFO - no previously-included directories found matching '.git*' 13:09:57 INFO - Installing collected packages: jsonschema, functools32 13:09:57 INFO - Running setup.py install for functools32 13:09:57 INFO - warning: no files found matching '*.txt' 13:09:57 INFO - no previously-included directories found matching 'build' 13:09:57 INFO - no previously-included directories found matching 'dist' 13:09:57 INFO - no previously-included directories found matching '.git*' 13:09:57 INFO - Successfully installed jsonschema functools32 13:09:57 INFO - Cleaning up... 13:09:57 INFO - Return code: 0 13:09:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:57 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 0x103636a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103646420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff343ca66a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5e00>, '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 0x10333edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034d0b20>, '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.QrspE2RtRF/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.eYiQUoFNjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QrspE2RtRF/Render', 13:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:57 INFO - 'HOME': '/Users/cltbld', 13:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:57 INFO - 'LOGNAME': 'cltbld', 13:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:57 INFO - 'MOZ_NO_REMOTE': '1', 13:09:57 INFO - 'NO_EM_RESTART': '1', 13:09:57 INFO - 'PAGER': '/bin/cat', 13:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:57 INFO - 'PWD': '/builds/slave/test', 13:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:57 INFO - 'SHELL': '/bin/bash', 13:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYiQUoFNjC/Listeners', 13:09:57 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:57 INFO - 'USER': 'cltbld', 13:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:57 INFO - 'XPC_FLAGS': '0x0', 13:09:57 INFO - 'XPC_SERVICE_NAME': '0', 13:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:58 INFO - Downloading/unpacking flake8 13:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:10:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:10:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:10:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:10:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:10:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:10:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:10:01 INFO - no previously-included directories found matching 'docs/_build' 13:10:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:10:01 INFO - Running setup.py install for pep8 13:10:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:10:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:10:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:10:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:10:02 INFO - no previously-included directories found matching 'docs/_build' 13:10:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:10:02 INFO - Cleaning up... 13:10:02 INFO - Return code: 0 13:10:02 INFO - Running post-action listener: _resource_record_post_action 13:10:02 INFO - Running post-action listener: _start_resource_monitoring 13:10:02 INFO - Starting resource monitoring. 13:10:02 INFO - ##### 13:10:02 INFO - ##### Running install step. 13:10:02 INFO - ##### 13:10:02 INFO - Running pre-action listener: _resource_record_pre_action 13:10:02 INFO - Running main action method: install 13:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:02 INFO - Reading from file tmpfile_stdout 13:10:02 INFO - Detecting whether we're running mozinstall >=1.0... 13:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:10:02 INFO - Reading from file tmpfile_stdout 13:10:02 INFO - Output received: 13:10:02 INFO - Usage: mozinstall [options] installer 13:10:02 INFO - Options: 13:10:02 INFO - -h, --help show this help message and exit 13:10:02 INFO - -d DEST, --destination=DEST 13:10:02 INFO - Directory to install application into. [default: 13:10:02 INFO - "/builds/slave/test"] 13:10:02 INFO - --app=APP Application being installed. [default: firefox] 13:10:02 INFO - mkdir: /builds/slave/test/build/application 13:10:02 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'] 13:10:02 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 13:10:24 INFO - Reading from file tmpfile_stdout 13:10:24 INFO - Output received: 13:10:24 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:10:24 INFO - Running post-action listener: _resource_record_post_action 13:10:24 INFO - ##### 13:10:24 INFO - ##### Running run-tests step. 13:10:24 INFO - ##### 13:10:24 INFO - Running pre-action listener: _resource_record_pre_action 13:10:24 INFO - Running main action method: run_tests 13:10:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:10:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:10:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:10:24 INFO - 2016-07-16 13:10:24.328 screenresolution[1664:7511] starting screenresolution argv=screenresolution get 13:10:24 INFO - 2016-07-16 13:10:24.331 screenresolution[1664:7511] Display 0: 1600x1200x32@60 13:10:24 INFO - 2016-07-16 13:10:24.336 screenresolution[1665:7513] starting screenresolution argv=screenresolution list 13:10:24 INFO - Available Modes on Display 0 13:10:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:10:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:10:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:10:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:10:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:10:24 INFO - Intel Iris: 13:10:24 INFO - Chipset Model: Intel Iris 13:10:24 INFO - Type: GPU 13:10:24 INFO - Bus: Built-In 13:10:24 INFO - VRAM (Dynamic, Max): 1536 MB 13:10:24 INFO - Vendor: Intel (0x8086) 13:10:24 INFO - Device ID: 0x0a2e 13:10:24 INFO - Revision ID: 0x0009 13:10:24 INFO - Displays: 13:10:24 INFO - Display: 13:10:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:10:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:10:24 INFO - Display Serial Number: 1600x1200 60 13:10:24 INFO - Main Display: Yes 13:10:24 INFO - Mirror: Off 13:10:24 INFO - Online: Yes 13:10:24 INFO - Rotation: Supported 13:10:24 INFO - Return code: 0 13:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:10:24 INFO - Python 2.7.3 13:10:24 INFO - Return code: 0 13:10:24 INFO - grabbing minidump binary from tooltool 13:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:24 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 0x1034d5e00>, '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 0x10333edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034d0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:10:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:10:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:10:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:10:24 INFO - Return code: 0 13:10:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:10:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:10:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:10:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:10:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:10:25 INFO - Return code: 0 13:10:25 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/1468493218/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:10:25 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/1468493218/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0278 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QrspE2RtRF/Render', 13:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:25 INFO - 'HOME': '/Users/cltbld', 13:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:25 INFO - 'LOGNAME': 'cltbld', 13:10:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:25 INFO - 'MOZ_NO_REMOTE': '1', 13:10:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:25 INFO - 'NO_EM_RESTART': '1', 13:10:25 INFO - 'PAGER': '/bin/cat', 13:10:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:25 INFO - 'PWD': '/builds/slave/test', 13:10:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:25 INFO - 'SHELL': '/bin/bash', 13:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYiQUoFNjC/Listeners', 13:10:25 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:25 INFO - 'USER': 'cltbld', 13:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:25 INFO - 'XPC_FLAGS': '0x0', 13:10:25 INFO - 'XPC_SERVICE_NAME': '0', 13:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:25 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/1468493218/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:10:25 INFO - mozversion application_buildid: 20160714034658 13:10:25 INFO - mozversion application_changeset: 2ba3feb910fb31f5fb3df3528b2991b3a37b05cf 13:10:25 INFO - mozversion application_display_name: Firefox 13:10:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:10:25 INFO - mozversion application_name: Firefox 13:10:25 INFO - mozversion application_remotingname: firefox 13:10:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:10:25 INFO - mozversion application_vendor: Mozilla 13:10:25 INFO - mozversion application_version: 48.0 13:10:25 INFO - mozversion platform_buildid: 20160714034658 13:10:25 INFO - mozversion platform_changeset: 2ba3feb910fb31f5fb3df3528b2991b3a37b05cf 13:10:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:10:25 INFO - mozversion platform_version: 48.0 13:10:25 INFO - using testdate: 1468699825 13:10:25 INFO - actual date: 1468699825 13:10:25 INFO - starting webserver on 'localhost:49272' 13:10:25 INFO - SUITE-START | Running 2 tests 13:10:25 INFO - TEST-START | dromaeo_css 13:10:25 INFO - operating with platform_type : mac_ 13:10:25 INFO - Initialising browser for dromaeo_css test... 13:10:26 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpbADd9c/profile http://localhost:49272/getInfo.html) 13:10:28 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 13:10:28 INFO - PROCESS | 1683 | colorDepth:24 13:10:28 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 13:10:28 INFO - PROCESS | 1683 | __metrics 13:10:28 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 13:10:29 INFO - TEST-INFO | 1683: exit 0 13:10:29 INFO - Browser initialized. 13:10:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:10:29 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpbADd9c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:41 INFO - PROCESS | 1688 | RSS: Main: 171094016 13:10:41 INFO - PROCESS | 1688 | 13:11:31 INFO - PROCESS | 1688 | 1468699891019 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:13:40 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 13:13:42 INFO - PROCESS | 1688 | RSS: Main: 182063104 13:13:42 INFO - PROCESS | 1688 | 13:16:44 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 13:16:44 INFO - PROCESS | 1688 | RSS: Main: 192712704 13:16:44 INFO - PROCESS | 1688 | 13:19:46 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 13:19:46 INFO - PROCESS | 1688 | RSS: Main: 194895872 13:19:46 INFO - PROCESS | 1688 | 13:22:48 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 13:22:49 INFO - PROCESS | 1688 | RSS: Main: 198582272 13:22:49 INFO - PROCESS | 1688 | 13:25:51 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 13:25:52 INFO - PROCESS | 1688 | RSS: Main: 197562368 13:25:52 INFO - PROCESS | 1688 | 13:28:54 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 13:28:54 INFO - PROCESS | 1688 | RSS: Main: 202993664 13:28:54 INFO - PROCESS | 1688 | 13:28:54 INFO - PROCESS | 1688 | __start_tp_report 13:28:54 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 13:28:54 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 13:28:54 INFO - PROCESS | 1688 | |i|pagename|runs| 13:28:54 INFO - PROCESS | 1688 | |0;dojo.html;2977.508711062674;3088.7837851350387;3707.406814909615;3743.7005039596834;3769.7926614036232;6049.274087109553;6076.422739839713;6149.200603921484;6165.075238714189;6167.414095660916;5065.265536497206;6032.607880487765;6060.727267272972;6134.171886795292;6170.845728856781;4652.860414187579;5483.917741233865;5515.944840551603;5548.805791797288;5631.774729010835;5433.701146436944;5528.75120619573;5544.445555444443;5571.8607034824045;5625.831225063234;5537.944620553783;5539.750711217985;5554.1113421852515;5557.055300598888;5564.527015203692;4606.286025666027;5530.778768849262;5615.943840561583;5616.494515493584;5622.606417550773;5449.455054494559;5511.834644960618;5533.861653458655;5598.300212473441;5614.326280846284;4870.245112007645;5772.422757724194;5835.649861008353;6054.364291749347;6078.483328917047;6353.332900045475;6404.583702059351;6422.614643121427;6433.163688720483;6437.935620643781;5505.009098362293;6465.515086368494;6495.6752162391695;6509.316521765194;6547.770828021044;6100.938990610126;6121.5139442231075;6125.357545073043;6205.6586887721605;6246.312905580383;6575.473962083021;6599.769008084694;6632.900506492407;6634.535582509275;6648.102506161703;6319.715612797435;6331.588446750947;6334.683265836689;6354.777582784581;6355.332690067568;5362.597805164628;6410.166678331787;6487.22153341602;6523.608583484911;6525.738970441129;5305.602079844027;6312.116303717483;6346.746130154742;6362.077498762654;6378.936210637927;6258.780942666985;6344.175257216532;6364.363563643691;6368.331325210879;6387.904181437282;5070.366204224472;5166.819161329336;5176.637635365489;5180.766865491062;5204.34945631796;4633.119707255611;4678.532146785362;4692.366530518405;4693.131770622445;4695.85912422621;6090.573659843857;6133.6319820810895;6165.260168779775;6197.101420294032;6215.782447614311;5684.033714268584;6331.366863313724;6417.358264173546;6487.870242595121;6558.278589355167;6211.3478084800445;6211.440970312694;6219.751209951552;6222.906656400158;6242.937570624326;5613.186088017214;5693.886122277531;5763.6541807491685;5764;5768.3654797972185;6716.697748601325;6723.66381680914;6726.192856857208;6727;6730.798076057726;6495.480361571157;6507.316731743288;6508.9349106508325;6513.641749703622;6517.543771935919;5604.943950560605;6560.671966401756;6732.798016059526;6764.797056088325;6811.625360605214;4787.880302992453;6350.174477317919;6381.074744162163;6395.552311338161;6395.552311338348;5476.6166368355425;6429.54993150475;6438.259600146043;6455.838604034937;6486.2216534016225;5882.647041177543;6276.1213430118905;6302.558820882494;6329.30377658448;6346.048092786119;6224.377562243921;6290.24517057956;6307.621542707452;6310.021946598285;6317.368263173646;5181.404138524118;6126.203593532812;6200.875982480416;6256.906146407717;6258.499320054476;5369.624126311277;6276.748930042747;6333.113364129118;6337.144485494399;6353.809385718436;6234.657093859882;6250.9062364065485;6256.749730010749;6262.2172228471445;6275.6548389839 13:28:54 INFO - PROCESS | 1688 | |1;ext.html;536.6109570561343;541.1179776963548;541.8997485465189;608.5314307982853;620.032748911698;37406.62593374065;38722.80638596803;38770;38868.80565597175;38884.99999999996;34359;41184.38223426651;41358.793206034;41386.96532586679;41525;9567.856482152773;9743.902560974371;9772.21822254218;9779.511024448784;9800.411975281506;9707.369021013646;9768.51157442125;9859.457729824857;9869.555869985832;9910.504474776268;9923;9929.652462163825;9956.6515171969;10017.198624110053;10056.949715251414;9915.504224788732;9922.057404546593;9970.850437243447;9973.900260997407;9996.95001524995;9782.266330025277;9818.9509052455;9868.950655246677;9928.50357482123;9936.602535898555;38860.417093743614;39124.80437597794;39300.60699393027;39579.60420395788;39658.40512392316;3287.901362959115;3387.627360990289;3494.668006539375;3800.4299355096955;3985.0236692010353;23723.16968906097;28095.719042809516;28425.43149137006;28499.860005599752;28579;2371.466420055474;2744.972550274492;2787;2795.622590950216;2833.263351528597;442764;443073;446412;449295;450849;37144;60877;61328;61329.693351533846;61337.079943800876;30370;36057.098572535375;36169.457458138146;36313.818430907675;36431.4535281971;16231.675366492604;16261.430849920196;16380.26288817006;16414.26135823891;16440.83559164417;13661.043726939019;13729;13740.175589464665;13794.793078103836;13850.584482465341;8296.294814940798;8322.6670933162;8326.66693332272;8335.791605209919;8393.24460798531;3225.419544423216;3487.3548393546766;3530.899115026555;3570.1967057411875;3587.8564857405413;917.7797328641078;1028.2082796246848;1033.9896601034043;1051.7738686182354;1178.7878181927165;30452.70768188991;30477.23806904801;30582.08253752391;30699.2325191872;30754;1168.3574034281282;1169.2867350915935;1172.876847930955;1194.811162892927;1231.4335405713293;15472.845271547141;15491.147986860831;15570.455034073753;15687.764683529756;15757.369705211662;620144;621959;622302;625361;626098;59472;60189.69905150534;60697.39302607006;60718;61070.694646526485;1528.7936128622493;1540.468538354266;1544.2433207728357;1573.3549244809574;1629.4541328655034;29848.403031939673;29937.850310749178;29953.101406957827;30462.390752185274;30597.08208753741;50720.492795073056;51132.74433627808;51157.721056973875;51456;51803.74098129485;545300.2734986299;549058;551588;553261;554835;26704.599431008162;26987.865060674572;27074;27114.32214194582;27549;46795;46983.06033879235;47248.527514725785;47798.80502987453;48266.55200343995;38589.84230472978;38680.6131938677;38759;39323.410148848365;39338.40992385174;36068.55725771045;38266.23467530689;38366.80816595899;38426.807865960494;38866.805665971486;32988.84539041122;37760;38440;39075;39733.60266397415;31829.522557162123;31956.8402157997;32105;32164.19589510281;32355.352892941537;24840;24883.129090481747;24919.750802491744;25238.49523009566;25240.242792716246 13:28:54 INFO - PROCESS | 1688 | |2;jquery.html;415.53460124660364;419.52593569266725;420.49960546949137;428.86490755412046;432.86797526754344;21113.68329475057;21296;21512.677309840346;22500.662490062663;23069.884650576725;22395.55208895821;22431.32706018818;22553.436164095907;22704.65943010852;22968.196113136044;5250.763715632796;6185.783497577586;6260.874782504347;6284.088807122965;6310.810675679737;4557.772111394417;5815.621984570989;6302.810915672537;6569.277379488252;6925.099737034204;6798.830029249259;6855.177378714561;6860.382565569098;6878;6884.0362349271145;6544.738210471575;6774.932250677529;6793.388595026471;6796.320367963189;6818.454523638122;5900.1739756434135;5956.612820166675;5961.076033214858;5970.432808883149;5970.492508136814;22370.44073898149;26697;27132.59301110485;27250.727492725215;27299.181024569294;1721.397510871185;2205.2061257947125;2259.107652477279;2358.7995020423286;2850.957235641467;15130.394784208618;15244.314005869763;15313.468653134709;15633.687326253412;16124.355025798954;1813.3200049981258;1843.308769196974;1871.0364162456347;1872.3353209610664;1926.1524929031182;110622;112305;113411;113947;114510.28234576488;11686.94156529212;11822.113341499422;11878;12007.579734709243;12008.159428840072;14748.778768318483;14940.028898121587;14947.626309342353;15021.248937553079;15058.472953446577;9403.059694030679;9432.434053956784;9471.147596716191;9541.856872146924;9566.712998610054;7821.217878212134;9449.43303401798;9543.952280238555;9589.952050239704;9608.471534065553;7354.852902942018;7356.301151390609;7358.558486490828;7378.262173782686;7525.962370188224;1957.8531610129298;2017;2080.521480059595;2094.6962690409805;2133.7012818205462;936.5644975086482;995.6067353395368;1022.3763504262394;1044.329073482422;1096.572336788653;21013.474663133544;21837.908104595026;21860.45348866259;22092.558148837255;22335.3299401015;897.6858099665066;1029.8867124616286;1040.7502199472071;1043.5095505112586;1083.8916108389099;10907.83638245427;11223.933726295989;11340.659780206606;11350;11360.829587556193;645528;646264;680215;693058;697510;116838;142344.57655423522;144485;146124.26937865242;147548.26225869017;1081.4808891732014;1101.2951710904867;1103.812351900179;1109.2180013090751;1109.628274528026;18447.907760461112;18718.719219211995;18850.71723924115;18882.67821252554;19002.049897504792;53927;54029.45970540244;54046.729766350916;54608.634784130714;55748.42267375525;82996;84563.5771821137;84781;84955;85777.57111214654;7380.704771809283;7402.9629851850395;8491.957540212507;8503.1921967413;8849.734507964771;8901.198892099743;9788;11865.822012669989;13200.405981731037;13741.931290343484;5517.089680202722;6109.877802444015;11553.267009948575;11595.536178552764;12019.278843269432;11338.716532086433;11427.60003399877;11525.596604118815;11593.362365069665;11687.649370518899;11802.409879506162;11827.349495777471;11972.940135299268;12114.394280286127;12195.451204695633;8539.701110461105;8555.871661924952;8568.35737319691;8622.655093796178;8690.391672582859;8580.418433335328;11658.6502404928;11743.823842642538;11833.526658933546;11834.46744896499 13:28:54 INFO - PROCESS | 1688 | |3;mootools.html;1483.866452019318;1640.983590164098;1856.7307740377646;1971;1979.5941831924456;8404;9067.501287429188;9160.26717862571;9372.531373431326;9387.577559009844;9032.367734258605;9078.727638170849;9202.987671356163;9211.309151813608;9216.032316606743;2269.8083506159232;2521.2436269119285;2557.4373637799654;2573;2575.8454492730402;2487.56467618167;2566.6278389633494;2587.7024142223695;2588.094167041539;2600.687917449899;2548.528522223385;2569.79441644668;2586.9611955820583;2590.5984572391217;2632.4340266842623;2544.847309161447;2568.550503661861;2570.961435578468;2578.755018273261;2587.443699604575;2541.0471073347494;2574.0604679291923;2584.862660429405;2587.2109006752935;2594.7534984176473;9115.817683646355;9288.442693438348;9335.206507446876;9346.299027572892;9370.812583748288;5664.49019588239;5699.515541179005;5701.059325211335;5856.560757943172;5906.379830117861;3620.7827530348;3783.5459744830523;3794.9810250948844;3798.16440383118;3826.081740382316;1061.9522121504551;1081.9513121909454;1089.3028461784463;1102.063246240697;1124.3591153042769;12533.498660053678;12552.937235313764;12626.873731262662;12635.747285054247;12655.493780248778;5049.394072711299;5096.898062038813;5129.1793313070475;5170.095233334151;5193.480651934777;10665;10712.46437678113;10722.678319650424;10734.731631709114;10740.462976851126;5757.539396848242;5832.504237139806;5836.037053886062;5854.853628659318;5863.882722345529;4630.930536041962;5078.7206703631655;5138.794448222104;5143.17709166539;5215.608829337815;4237.745735255895;4310.913781724411;4324.372965919924;4411.580899814512;4412.271975124133;1410.3230449384148;1421.8649228323293;1447.0666420158939;1453.9345729441989;1465.4504560789703;937.6999360204805;938.6714649872627;944.7449188719007;960.9231261499203;975.4342481360935;5976.701164941735;6072.969635151796;6232.657203853741;6245.6252624842655;6254.312025677263;481.9253015782559;489.89222371078307;492.72899905052077;1054.8312270036756;1063.2557209953063;4013.3578627420056;4052.149048699806;4067.2882245607493;4099.9180016399505;4111.054457474797;10912;11325.886741132648;11400.486978086006;11507.194496385173;11529.654110376701;9127.543622818832;9542.3320367575;10215.23385746072;10283.9485802572;11050.889491105147;8626.439281446686;8801.47191168532;8823.647054117764;8825.205731484197;8847.513386763661;5277.868053298698;5846.766129354778;5914.674692891932;6116.5412594056515;6119.510439164767;9895.455749933823;9947.900520994697;9962.153216976638;10251.58993640246;10345.275830691779;9933.205343572641;10274.486275686037;10286.742831429274;10536.631217907336;10543.472826358804;7189.676464559003;7694.4229182810395;7768.067831860213;7883.684652614061;7946.046474423106;8549.87175192385;8753.78115547091;8815.955920220358;8833.381663283508;8872.778180545538;7621.428392870446;7736.187700291388;7749.031371078615;7840.686372545034;7880.487768295043;7590.696372145052;7594.278543538355;7598.810029749079;7636.12184598756;7764.689412423666;7352.191258961617;7442.851142977219;7445.516041457288;7468.887966680395;7476.476646634684;4988.176950803077;5016.247562865599;5160.045391602565;5203.713795741271;5207.92188117171;5162.870928226825;5174.404943431554;5240.790368385222;5395.352557692945;5418.891622167614 13:28:54 INFO - PROCESS | 1688 | |4;prototype.html;314.86932922837025;320.383262220226;343.2705500810778;343.9776414533055;346.7122288500545;6642.568233064848;6699.464042876571;6813.28460511646;6855.520113592044;6874.243833178352;6792.626405547693;6848.4178844798125;6848.863022739542;6889.689963951621;6912.619805910673;5031.371078615173;5047.369078865142;5048.192289233723;5067.8479645610505;5093.134167191568;5079.74601269935;5081.974590127063;5092.8472145835685;5101.464346243647;5105.8767071244265;5005.54950054495;5005.799768009293;5008.724520151391;5034.798608055673;5036.194208926572;4829.720124167098;4936.925946110811;5011.574016208627;5025.849224523252;5042.722650254234;3363.6131844837914;4271.508776490712;4283.97858010711;4298.591633794816;4298.677599180042;6563.113979612786;6584.275729669733;6590.769323073718;6598.241202261754;6608.0418339341;5943.3165186003735;5962.761489540413;5964.791232306892;5978.44560414291;5984.760609575612;5825.83483303341;7133.92866071343;7346.522476039094;7377.225391333886;7385.66764495599;4524.932126018112;4677.929831052537;4691.62467002639;4777.570018698334;4789.56893879549;7717.151113377524;7757.1854955229455;7789.766307010798;7793.376529877596;7830.6084695764985;4776.498467660915;4783.1390349737385;4785.1625965455905;4790.850195952946;4800.975995120002;4879.170541008037;4882.292067650171;4886.828960986349;4905.2151655734915;4926.211806111077;4795.520447955177;5898.4101589840675;5898.911516327258;5901.616394934315;5926.525877929756;5918.852028699317;7133.714651413885;7399.334059934632;7439;7442.292982166686;1334.292824802856;1449.9565013049626;1613.3062783003422;1613.628415846521;1672.9414470493475;995.1342332170913;1040.5317607076845;1052.5105825791045;1065.8880817514205;1068.7274744939991;6399.360063993657;6728.764493242811;6906.37842594169;6940.305969403019;6950.200726916368;7004.2645522220455;7699.422543309274;7700.152983171846;7702.229777022253;7729.381649468029;6870.656467176721;6905.861882762317;6911.6544172791155;6914.101166848278;6929.376356127973;3448.413769659164;3804.6195380462286;4036.414719865662;4071.226466971266;4076.898077548085;8021.7994550135545;8071.4349995500925;8073.434859559775;8094.676212951534;8115.79710507242;7886.960565197137;7945.761627151194;7958.6418611162635;7972.123066462685;7973.800654983555;8015.238552337519;8051.194880512019;8082.353411727047;8088.4742491739025;8094.919050809534;7344.632768361454;7617.047869016373;7637.961810191136;7678.308952194329;7711.575863327571;7505.662245199088;7547.50941188821;7548.811279718051;7573.242675732383;7598.012258406372;6411.93588064132;8024.638891249791;8042.276195142465;8062.516249024842;8069.556174410229;4642.791074401593;4760.857174284777;4814.542618451242;4821.300911367902;4821.325014498043;6263;7260.528065675714;7658.655360508902;7667.271609197117;7673.577953212627;6625.873601487662;7353;7367.631618419165;7389.150247721581;7389.261073892568;6745.392914637706;7340.11918569775;7341.449391295568;7355.485116041826;7357.668904899186;7153.82115447118;7155.8568828624175;7163.391111755559;7188.317109874553;7214.2785721427435;7172.211056783645;7403.629818508945;7478.925210748041;7482.176960534228;7488.101427828696;6914.792556223321;7020.946857971345;7142.428605711634;7171.713131474683;7212.3148300911325 13:28:54 INFO - PROCESS | 1688 | |5;yui.html;632.702629764011;663.0783211336246;771.4291424345982;786.3119770201074;791.5171745235409;11782.410879456025;13383.732325353487;15363.15502647354;15673.608159795996;15696.921515392421;14052;14220.71558568828;14539.49111781088;14627.049241799275;14662.12027278364;778.3811869563682;937.8030613571158;948.8481842905119;958.712386284112;970.776721354089;929.5770424456856;944.1691311645742;946.517276189145;947.5783276441986;949.2074118111385;1019.7603563162688;1024.0629823711295;1026.153423425673;1027.7995790820794;1028.300755486269;1010.9241806864478;1011.7622358745689;1012.4330374990029;1016.217512515359;1018.974525636865;733.2410954661899;747.7382915979418;760.5132715062365;761.0220866186978;762.4319881688123;15183.240837958168;15240.923795381063;15258.313375898111;15405.691886162325;15471.303791329417;12854;12893.613191604267;12973.378327709037;13059.608211753663;13208.405621746948;10039.901536506897;10187.981201879827;10323.690289291333;10353.637622683245;10544.841827372518;3600.837962291703;3855.363864962306;4114.403411505315;4122.855700050513;4398.73607583546;85422.14577854204;86139;86220;89499.55250223707;89810.55094724485;9608.711738647851;9696.51517424126;9875.012498750211;9915.256355773201;10005.699829005142;21506.784932150793;21709.782902170777;21827.345179644635;21909.452263693536;21976.34070977873;7614.619269036526;7783;7790.220977902278;7791.376689864911;7882.408819338572;4165.062860856283;4179.2059508693255;4204.033072393367;4211.410402543646;4212.831486740557;3741.663250307431;3801.5248093988253;3828.272628200633;3834.2331533692814;3836.1752223271574;673.0980486148584;686.9381755642016;689.2074114768056;692.1693967239333;696.2584847137782;488.9584385327216;491.3538696613941;577.8873119741694;591.030709636197;604.099891162174;6224;7104.396126329217;7827.099883513469;7918.287354138155;8155.34757219421;568.9857753556195;579.9101139323411;612.3447910735559;613.7759717703007;621.2141640824361;3616;3756.4553139794575;3777.7355585109326;3785.962140378616;3827.8660246891227;86866;87072.5646371764;87646;89013.10986890178;89399.21201575932;80036.39927201423;80663.59668201621;81021.18978810136;81108.59445702734;81346.77979830308;72187.6390618054;72796.63601681958;73060.63469682618;73981.63009185027;74135.62932185413;6878.7248510059035;7077.150741911004;7434.5167564110325;7496.325330720261;7674.6930122794465;49614.50385496099;49781.00437991292;50213.74893125511;50320.46474887832;52540;61518;68188.6590567044;68355;69192.6540367295;70661.23346916368;8322.875156872773;9853;9879;9895.950520247352;10812.621558245424;11928.403579821148;12157.1489995703;12171.81742273849;12253.448594813433;12626.494940202288;11419.771604567695;11483.36841473727;11560.30638161713;11560.959513643813;11990.220635658654;11170.050545703707;11370.374629395132;11469.541218351173;11502.769944601228;11692.298462092302;9206.447613143233;11202.59319286872;11319.037881780141;11489.712757180803;11671.066314694974;9268.58291376903;9313.534323283673;9477.668281610111;9677.274204434554;9755.804883902425;9663.371880828005;9740.464274464972;9773.315867889463;9797.97121302253;9852.507374631383 13:28:54 INFO - PROCESS | 1688 | __end_tp_report 13:28:54 INFO - PROCESS | 1688 | __start_cc_report 13:28:54 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,395 13:28:54 INFO - PROCESS | 1688 | __end_cc_report 13:28:54 INFO - PROCESS | 1688 | __startTimestamp1468700934833__endTimestamp 13:28:54 INFO - PROCESS | 1688 | 13:28:54 INFO - PROCESS | 1688 | ------- Summary: start ------- 13:28:54 INFO - PROCESS | 1688 | Number of tests: 6 13:28:54 INFO - PROCESS | 1688 | 13:28:54 INFO - PROCESS | 1688 | [#0] dojo.html Cycles:165 Average:5950.57 Median:6215.78 stddev:685.94 (11.0%) stddev-sans-first:647.18 13:28:54 INFO - PROCESS | 1688 | Values: 2977.5 3088.8 3707.4 3743.7 3769.8 6049.3 6076.4 6149.2 6165.1 6167.4 5065.3 6032.6 6060.7 6134.2 6170.8 4652.9 5483.9 5515.9 5548.8 5631.8 5433.7 5528.8 5544.4 5571.9 5625.8 5537.9 5539.8 5554.1 5557.1 5564.5 4606.3 5530.8 5615.9 5616.5 5622.6 5449.5 5511.8 5533.9 5598.3 5614.3 4870.2 5772.4 5835.6 6054.4 6078.5 6353.3 6404.6 6422.6 6433.2 6437.9 5505.0 6465.5 6495.7 6509.3 6547.8 6100.9 6121.5 6125.4 6205.7 6246.3 6575.5 6599.8 6632.9 6634.5 6648.1 6319.7 6331.6 6334.7 6354.8 6355.3 5362.6 6410.2 6487.2 6523.6 6525.7 5305.6 6312.1 6346.7 6362.1 6378.9 6258.8 6344.2 6364.4 6368.3 6387.9 5070.4 5166.8 5176.6 5180.8 5204.3 4633.1 4678.5 4692.4 4693.1 4695.9 6090.6 6133.6 6165.3 6197.1 6215.8 5684.0 6331.4 6417.4 6487.9 6558.3 6211.3 6211.4 6219.8 6222.9 6242.9 5613.2 5693.9 5763.7 5764.0 5768.4 6716.7 6723.7 6726.2 6727.0 6730.8 6495.5 6507.3 6508.9 6513.6 6517.5 5604.9 6560.7 6732.8 6764.8 6811.6 4787.9 6350.2 6381.1 6395.6 6395.6 5476.6 6429.5 6438.3 6455.8 6486.2 5882.6 6276.1 6302.6 6329.3 6346.0 6224.4 6290.2 6307.6 6310.0 6317.4 5181.4 6126.2 6200.9 6256.9 6258.5 5369.6 6276.7 6333.1 6337.1 6353.8 6234.7 6250.9 6256.7 6262.2 6275.7 13:28:54 INFO - PROCESS | 1688 | 13:28:54 INFO - PROCESS | 1688 | [#1] ext.html Cycles:180 Average:66480.72 Median:38635.23 stddev:145734.04 (377.2%) stddev-sans-first:146058.75 13:28:54 INFO - PROCESS | 1688 | Values: 536.6 541.1 541.9 608.5 620.0 37406.6 38722.8 38770.0 38868.8 38885.0 34359.0 41184.4 41358.8 41387.0 41525.0 9567.9 9743.9 9772.2 9779.5 9800.4 9707.4 9768.5 9859.5 9869.6 9910.5 9923.0 9929.7 9956.7 10017.2 10056.9 9915.5 9922.1 9970.9 9973.9 9997.0 9782.3 9819.0 9869.0 9928.5 9936.6 38860.4 39124.8 39300.6 39579.6 39658.4 3287.9 3387.6 3494.7 3800.4 3985.0 23723.2 28095.7 28425.4 28499.9 28579.0 2371.5 2745.0 2787.0 2795.6 2833.3 442764.0 443073.0 446412.0 449295.0 450849.0 37144.0 60877.0 61328.0 61329.7 61337.1 30370.0 36057.1 36169.5 36313.8 36431.5 16231.7 16261.4 16380.3 16414.3 16440.8 13661.0 13729.0 13740.2 13794.8 13850.6 8296.3 8322.7 8326.7 8335.8 8393.2 3225.4 3487.4 3530.9 3570.2 3587.9 917.8 1028.2 1034.0 1051.8 1178.8 30452.7 30477.2 30582.1 30699.2 30754.0 1168.4 1169.3 1172.9 1194.8 1231.4 15472.8 15491.1 15570.5 15687.8 15757.4 620144.0 621959.0 622302.0 625361.0 626098.0 59472.0 60189.7 60697.4 60718.0 61070.7 1528.8 1540.5 1544.2 1573.4 1629.5 29848.4 29937.9 29953.1 30462.4 30597.1 50720.5 51132.7 51157.7 51456.0 51803.7 545300.3 549058.0 551588.0 553261.0 554835.0 26704.6 26987.9 27074.0 27114.3 27549.0 46795.0 46983.1 47248.5 47798.8 48266.6 38589.8 38680.6 38759.0 39323.4 39338.4 36068.6 38266.2 38366.8 38426.8 38866.8 32988.8 37760.0 38440.0 39075.0 39733.6 31829.5 31956.8 32105.0 32164.2 32355.4 24840.0 24883.1 24919.8 25238.5 25240.2 13:28:54 INFO - PROCESS | 1688 | 13:28:54 INFO - PROCESS | 1688 | [#2] jquery.html Cycles:180 Average:38015.07 Median:22527.05 stddev:111827.02 (496.4%) stddev-sans-first:112105.08 13:28:54 INFO - PROCESS | 1688 | Values: 415.5 419.5 420.5 428.9 432.9 21113.7 21296.0 21512.7 22500.7 23069.9 22395.6 22431.3 22553.4 22704.7 22968.2 5250.8 6185.8 6260.9 6284.1 6310.8 4557.8 5815.6 6302.8 6569.3 6925.1 6798.8 6855.2 6860.4 6878.0 6884.0 6544.7 6774.9 6793.4 6796.3 6818.5 5900.2 5956.6 5961.1 5970.4 5970.5 22370.4 26697.0 27132.6 27250.7 27299.2 1721.4 2205.2 2259.1 2358.8 2851.0 15130.4 15244.3 15313.5 15633.7 16124.4 1813.3 1843.3 1871.0 1872.3 1926.2 110622.0 112305.0 113411.0 113947.0 114510.3 11686.9 11822.1 11878.0 12007.6 12008.2 14748.8 14940.0 14947.6 15021.2 15058.5 9403.1 9432.4 9471.1 9541.9 9566.7 7821.2 9449.4 9544.0 9590.0 9608.5 7354.9 7356.3 7358.6 7378.3 7526.0 1957.9 2017.0 2080.5 2094.7 2133.7 936.6 995.6 1022.4 1044.3 1096.6 21013.5 21837.9 21860.5 22092.6 22335.3 897.7 1029.9 1040.8 1043.5 1083.9 10907.8 11223.9 11340.7 11350.0 11360.8 645528.0 646264.0 680215.0 693058.0 697510.0 116838.0 142344.6 144485.0 146124.3 147548.3 1081.5 1101.3 1103.8 1109.2 1109.6 18447.9 18718.7 18850.7 18882.7 19002.0 53927.0 54029.5 54046.7 54608.6 55748.4 82996.0 84563.6 84781.0 84955.0 85777.6 7380.7 7403.0 8492.0 8503.2 8849.7 8901.2 9788.0 11865.8 13200.4 13741.9 5517.1 6109.9 11553.3 11595.5 12019.3 11338.7 11427.6 11525.6 11593.4 11687.6 11802.4 11827.3 11972.9 12114.4 12195.5 8539.7 8555.9 8568.4 8622.7 8690.4 8580.4 11658.7 11743.8 11833.5 11834.5 13:28:54 INFO - PROCESS | 1688 | 13:28:54 INFO - PROCESS | 1688 | [#3] mootools.html Cycles:180 Average:5995.00 Median:5133.99 stddev:3314.23 (64.6%) stddev-sans-first:3306.18 13:28:54 INFO - PROCESS | 1688 | Values: 1483.9 1641.0 1856.7 1971.0 1979.6 8404.0 9067.5 9160.3 9372.5 9387.6 9032.4 9078.7 9203.0 9211.3 9216.0 2269.8 2521.2 2557.4 2573.0 2575.8 2487.6 2566.6 2587.7 2588.1 2600.7 2548.5 2569.8 2587.0 2590.6 2632.4 2544.8 2568.6 2571.0 2578.8 2587.4 2541.0 2574.1 2584.9 2587.2 2594.8 9115.8 9288.4 9335.2 9346.3 9370.8 5664.5 5699.5 5701.1 5856.6 5906.4 3620.8 3783.5 3795.0 3798.2 3826.1 1062.0 1082.0 1089.3 1102.1 1124.4 12533.5 12552.9 12626.9 12635.7 12655.5 5049.4 5096.9 5129.2 5170.1 5193.5 10665.0 10712.5 10722.7 10734.7 10740.5 5757.5 5832.5 5836.0 5854.9 5863.9 4630.9 5078.7 5138.8 5143.2 5215.6 4237.7 4310.9 4324.4 4411.6 4412.3 1410.3 1421.9 1447.1 1453.9 1465.5 937.7 938.7 944.7 960.9 975.4 5976.7 6073.0 6232.7 6245.6 6254.3 481.9 489.9 492.7 1054.8 1063.3 4013.4 4052.1 4067.3 4099.9 4111.1 10912.0 11325.9 11400.5 11507.2 11529.7 9127.5 9542.3 10215.2 10283.9 11050.9 8626.4 8801.5 8823.6 8825.2 8847.5 5277.9 5846.8 5914.7 6116.5 6119.5 9895.5 9947.9 9962.2 10251.6 10345.3 9933.2 10274.5 10286.7 10536.6 10543.5 7189.7 7694.4 7768.1 7883.7 7946.0 8549.9 8753.8 8816.0 8833.4 8872.8 7621.4 7736.2 7749.0 7840.7 7880.5 7590.7 7594.3 7598.8 7636.1 7764.7 7352.2 7442.9 7445.5 7468.9 7476.5 4988.2 5016.2 5160.0 5203.7 5207.9 5162.9 5174.4 5240.8 5395.4 5418.9 13:28:54 INFO - PROCESS | 1688 | 13:28:54 INFO - PROCESS | 1688 | [#4] prototype.html Cycles:180 Average:5988.26 Median:6830.85 stddev:1956.55 (28.6%) stddev-sans-first:1915.14 13:28:54 INFO - PROCESS | 1688 | Values: 314.9 320.4 343.3 344.0 346.7 6642.6 6699.5 6813.3 6855.5 6874.2 6792.6 6848.4 6848.9 6889.7 6912.6 5031.4 5047.4 5048.2 5067.8 5093.1 5079.7 5082.0 5092.8 5101.5 5105.9 5005.5 5005.8 5008.7 5034.8 5036.2 4829.7 4936.9 5011.6 5025.8 5042.7 3363.6 4271.5 4284.0 4298.6 4298.7 6563.1 6584.3 6590.8 6598.2 6608.0 5943.3 5962.8 5964.8 5978.4 5984.8 5825.8 7133.9 7346.5 7377.2 7385.7 4524.9 4677.9 4691.6 4777.6 4789.6 7717.2 7757.2 7789.8 7793.4 7830.6 4776.5 4783.1 4785.2 4790.9 4801.0 4879.2 4882.3 4886.8 4905.2 4926.2 4795.5 5898.4 5898.9 5901.6 5926.5 5918.9 7133.7 7399.3 7439.0 7442.3 1334.3 1450.0 1613.3 1613.6 1672.9 995.1 1040.5 1052.5 1065.9 1068.7 6399.4 6728.8 6906.4 6940.3 6950.2 7004.3 7699.4 7700.2 7702.2 7729.4 6870.7 6905.9 6911.7 6914.1 6929.4 3448.4 3804.6 4036.4 4071.2 4076.9 8021.8 8071.4 8073.4 8094.7 8115.8 7887.0 7945.8 7958.6 7972.1 7973.8 8015.2 8051.2 8082.4 8088.5 8094.9 7344.6 7617.0 7638.0 7678.3 7711.6 7505.7 7547.5 7548.8 7573.2 7598.0 6411.9 8024.6 8042.3 8062.5 8069.6 4642.8 4760.9 4814.5 4821.3 4821.3 6263.0 7260.5 7658.7 7667.3 7673.6 6625.9 7353.0 7367.6 7389.2 7389.3 6745.4 7340.1 7341.4 7355.5 7357.7 7153.8 7155.9 7163.4 7188.3 7214.3 7172.2 7403.6 7478.9 7482.2 7488.1 6914.8 7020.9 7142.4 7171.7 7212.3 13:28:54 INFO - PROCESS | 1688 | 13:28:54 INFO - PROCESS | 1688 | [#5] yui.html Cycles:180 Average:18537.78 Median:585.47 stddev:26213.09 (4477.3%) stddev-sans-first:26252.15 13:28:54 INFO - PROCESS | 1688 | Values: 632.7 663.1 771.4 786.3 791.5 11782.4 13383.7 15363.2 15673.6 15696.9 14052.0 14220.7 14539.5 14627.0 14662.1 778.4 937.8 948.8 958.7 970.8 929.6 944.2 946.5 947.6 949.2 1019.8 1024.1 1026.2 1027.8 1028.3 1010.9 1011.8 1012.4 1016.2 1019.0 733.2 747.7 760.5 761.0 762.4 15183.2 15240.9 15258.3 15405.7 15471.3 12854.0 12893.6 12973.4 13059.6 13208.4 10039.9 10188.0 10323.7 10353.6 10544.8 3600.8 3855.4 4114.4 4122.9 4398.7 85422.1 86139.0 86220.0 89499.6 89810.6 9608.7 9696.5 9875.0 9915.3 10005.7 21506.8 21709.8 21827.3 21909.5 21976.3 7614.6 7783.0 7790.2 7791.4 7882.4 4165.1 4179.2 4204.0 4211.4 4212.8 3741.7 3801.5 3828.3 3834.2 3836.2 673.1 686.9 689.2 692.2 696.3 489.0 491.4 577.9 591.0 604.1 6224.0 7104.4 7827.1 7918.3 8155.3 569.0 579.9 612.3 613.8 621.2 3616.0 3756.5 3777.7 3786.0 3827.9 86866.0 87072.6 87646.0 89013.1 89399.2 80036.4 80663.6 81021.2 81108.6 81346.8 72187.6 72796.6 73060.6 73981.6 74135.6 6878.7 7077.2 7434.5 7496.3 7674.7 49614.5 49781.0 50213.7 50320.5 52540.0 61518.0 68188.7 68355.0 69192.7 70661.2 8322.9 9853.0 9879.0 9896.0 10812.6 11928.4 12157.1 12171.8 12253.4 12626.5 11419.8 11483.4 11560.3 11561.0 11990.2 11170.1 11370.4 11469.5 11502.8 11692.3 9206.4 11202.6 11319.0 11489.7 11671.1 9268.6 9313.5 9477.7 9677.3 9755.8 9663.4 9740.5 9773.3 9798.0 9852.5 13:28:54 INFO - PROCESS | 1688 | -------- Summary: end -------- 13:28:54 INFO - PROCESS | 1688 | 13:28:55 INFO - TEST-INFO | 1688: exit 0 13:28:55 INFO - TEST-OK | dromaeo_css | took 1109349ms 13:28:55 INFO - TEST-START | kraken 13:28:55 INFO - operating with platform_type : mac_ 13:28:55 INFO - Initialising browser for kraken test... 13:28:55 INFO - TEST-INFO | started process 1807 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpoFezvK/profile http://localhost:49272/getInfo.html) 13:28:57 INFO - PROCESS | 1807 | __metrics Screen width/height:1600/1200 13:28:57 INFO - PROCESS | 1807 | colorDepth:24 13:28:57 INFO - PROCESS | 1807 | Browser inner width/height: 1024/689 13:28:57 INFO - PROCESS | 1807 | __metrics 13:28:57 ERROR - PROCESS | 1807 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 13:28:58 INFO - TEST-INFO | 1807: exit 0 13:28:58 INFO - Browser initialized. 13:28:58 INFO - Running cycle 1/1 for kraken test... 13:28:58 INFO - TEST-INFO | started process 1811 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpoFezvK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:29:10 INFO - PROCESS | 1811 | RSS: Main: 170921984 13:29:10 INFO - PROCESS | 1811 | 13:29:13 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 13:29:13 INFO - PROCESS | 1811 | RSS: Main: 183820288 13:29:13 INFO - PROCESS | 1811 | 13:29:16 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 13:29:17 INFO - PROCESS | 1811 | RSS: Main: 192520192 13:29:17 INFO - PROCESS | 1811 | 13:29:20 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 13:29:21 INFO - PROCESS | 1811 | RSS: Main: 195977216 13:29:21 INFO - PROCESS | 1811 | 13:29:22 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 13:29:23 INFO - PROCESS | 1811 | RSS: Main: 196227072 13:29:23 INFO - PROCESS | 1811 | 13:29:25 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:29:26 INFO - PROCESS | 1811 | RSS: Main: 197750784 13:29:26 INFO - PROCESS | 1811 | 13:29:29 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 13:29:29 INFO - PROCESS | 1811 | RSS: Main: 198152192 13:29:29 INFO - PROCESS | 1811 | 13:29:32 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 13:29:33 INFO - PROCESS | 1811 | RSS: Main: 198021120 13:29:33 INFO - PROCESS | 1811 | 13:29:35 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 13:29:36 INFO - PROCESS | 1811 | RSS: Main: 198000640 13:29:36 INFO - PROCESS | 1811 | 13:29:38 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:29:38 INFO - PROCESS | 1811 | RSS: Main: 197783552 13:29:38 INFO - PROCESS | 1811 | 13:29:40 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:29:41 INFO - PROCESS | 1811 | RSS: Main: 197754880 13:29:41 INFO - PROCESS | 1811 | 13:29:43 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:29:44 INFO - PROCESS | 1811 | RSS: Main: 197763072 13:29:44 INFO - PROCESS | 1811 | 13:29:47 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:29:47 INFO - PROCESS | 1811 | RSS: Main: 197959680 13:29:47 INFO - PROCESS | 1811 | 13:29:50 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:51 INFO - PROCESS | 1811 | RSS: Main: 197869568 13:29:51 INFO - PROCESS | 1811 | 13:29:52 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 13:29:53 INFO - PROCESS | 1811 | RSS: Main: 199520256 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | __start_tp_report 13:29:53 INFO - PROCESS | 1811 | _x_x_mozilla_page_load 13:29:53 INFO - PROCESS | 1811 | _x_x_mozilla_page_load_details 13:29:53 INFO - PROCESS | 1811 | |i|pagename|runs| 13:29:53 INFO - PROCESS | 1811 | |0;ai-astar;117;111;117;117;117;132;116;111;113;117 13:29:53 INFO - PROCESS | 1811 | |1;audio-beat-detection;151;118;143;151;119;144;140;109;204;143 13:29:53 INFO - PROCESS | 1811 | |2;audio-dft;195;200;198;199;198;193;201;202;199;195 13:29:53 INFO - PROCESS | 1811 | |3;audio-fft;66;82;74;143;58;57;56;64;125;55 13:29:53 INFO - PROCESS | 1811 | |4;audio-oscillator;77;80;124;75;78;84;120;85;110;154 13:29:53 INFO - PROCESS | 1811 | |5;imaging-gaussian-blur;89;87;89;88;130;85;92;86;89;85 13:29:53 INFO - PROCESS | 1811 | |6;imaging-darkroom;94;113;149;125;94;117;115;95;93;95 13:29:53 INFO - PROCESS | 1811 | |7;imaging-desaturate;89;92;91;88;91;88;99;129;88;90 13:29:53 INFO - PROCESS | 1811 | |8;json-parse-financial;59;64;64;64;64;74;93;108;94;82 13:29:53 INFO - PROCESS | 1811 | |9;json-stringify-tinderbox;61;66;87;95;98;73;70;85;66;66 13:29:53 INFO - PROCESS | 1811 | |10;stanford-crypto-aes;81;102;99;88;80;77;86;101;99;106 13:29:53 INFO - PROCESS | 1811 | |11;stanford-crypto-ccm;127;141;140;116;152;146;149;147;141;139 13:29:53 INFO - PROCESS | 1811 | |12;stanford-crypto-pbkdf2;164;176;165;162;167;172;164;167;162;161 13:29:53 INFO - PROCESS | 1811 | |13;stanford-crypto-sha256-iterative;66;68;66;70;65;65;68;67;70;68 13:29:53 INFO - PROCESS | 1811 | __end_tp_report 13:29:53 INFO - PROCESS | 1811 | __start_cc_report 13:29:53 INFO - PROCESS | 1811 | _x_x_mozilla_cycle_collect,1046 13:29:53 INFO - PROCESS | 1811 | __end_cc_report 13:29:53 INFO - PROCESS | 1811 | __startTimestamp1468700993080__endTimestamp 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | ------- Summary: start ------- 13:29:53 INFO - PROCESS | 1811 | Number of tests: 14 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#0] ai-astar Cycles:10 Average:116.80 Median:117.00 stddev:5.90 (5.0%) stddev-sans-first:6.26 13:29:53 INFO - PROCESS | 1811 | Values: 117.0 111.0 117.0 117.0 117.0 132.0 116.0 111.0 113.0 117.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:143.50 stddev:26.27 (18.3%) stddev-sans-first:27.67 13:29:53 INFO - PROCESS | 1811 | Values: 151.0 118.0 143.0 151.0 119.0 144.0 140.0 109.0 204.0 143.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#2] audio-dft Cycles:10 Average:198.00 Median:199.00 stddev:2.87 (1.4%) stddev-sans-first:2.83 13:29:53 INFO - PROCESS | 1811 | Values: 195.0 200.0 198.0 199.0 198.0 193.0 201.0 202.0 199.0 195.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#3] audio-fft Cycles:10 Average:78.00 Median:61.00 stddev:31.02 (50.9%) stddev-sans-first:32.60 13:29:53 INFO - PROCESS | 1811 | Values: 66.0 82.0 74.0 143.0 58.0 57.0 56.0 64.0 125.0 55.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:77.50 stddev:26.86 (34.7%) stddev-sans-first:27.32 13:29:53 INFO - PROCESS | 1811 | Values: 77.0 80.0 124.0 75.0 78.0 84.0 120.0 85.0 110.0 154.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:88.50 stddev:13.52 (15.3%) stddev-sans-first:14.30 13:29:53 INFO - PROCESS | 1811 | Values: 89.0 87.0 89.0 88.0 130.0 85.0 92.0 86.0 89.0 85.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#6] imaging-darkroom Cycles:10 Average:109.00 Median:93.50 stddev:18.47 (19.8%) stddev-sans-first:18.77 13:29:53 INFO - PROCESS | 1811 | Values: 94.0 113.0 149.0 125.0 94.0 117.0 115.0 95.0 93.0 95.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:90.50 stddev:12.55 (13.9%) stddev-sans-first:13.16 13:29:53 INFO - PROCESS | 1811 | Values: 89.0 92.0 91.0 88.0 91.0 88.0 99.0 129.0 88.0 90.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#8] json-parse-financial Cycles:10 Average:76.60 Median:69.00 stddev:16.79 (24.3%) stddev-sans-first:16.56 13:29:53 INFO - PROCESS | 1811 | Values: 59.0 64.0 64.0 64.0 64.0 74.0 93.0 108.0 94.0 82.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#9] json-stringify-tinderbox Cycles:10 Average:76.70 Median:79.00 stddev:13.38 (16.9%) stddev-sans-first:12.93 13:29:53 INFO - PROCESS | 1811 | Values: 61.0 66.0 87.0 95.0 98.0 73.0 70.0 85.0 66.0 66.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:83.50 stddev:10.63 (12.7%) stddev-sans-first:10.52 13:29:53 INFO - PROCESS | 1811 | Values: 81.0 102.0 99.0 88.0 80.0 77.0 86.0 101.0 99.0 106.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:143.50 stddev:10.84 (7.6%) stddev-sans-first:10.46 13:29:53 INFO - PROCESS | 1811 | Values: 127.0 141.0 140.0 116.0 152.0 146.0 149.0 147.0 141.0 139.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:166.00 stddev:4.76 (2.9%) stddev-sans-first:4.99 13:29:53 INFO - PROCESS | 1811 | Values: 164.0 176.0 165.0 162.0 167.0 172.0 164.0 167.0 162.0 161.0 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - PROCESS | 1811 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.83 (2.7%) stddev-sans-first:1.88 13:29:53 INFO - PROCESS | 1811 | Values: 66.0 68.0 66.0 70.0 65.0 65.0 68.0 67.0 70.0 68.0 13:29:53 INFO - PROCESS | 1811 | -------- Summary: end -------- 13:29:53 INFO - PROCESS | 1811 | 13:29:53 INFO - TEST-INFO | 1811: exit 0 13:29:53 INFO - TEST-OK | kraken | took 58504ms 13:29:53 INFO - SUITE-END | took 1167s 13:29:54 INFO - Completed test suite (00:19:28) 13:29:54 INFO - javascript benchmark 13:29:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2977.508711062674, 3088.7837851350387, 3707.406814909615, 3743.7005039596834, 3769.7926614036232, 6049.274087109553, 6076.422739839713, 6149.200603921484, 6165.075238714189, 6167.414095660916, 5065.265536497206, 6032.607880487765, 6060.727267272972, 6134.171886795292, 6170.845728856781, 4652.860414187579, 5483.917741233865, 5515.944840551603, 5548.805791797288, 5631.774729010835, 5433.701146436944, 5528.75120619573, 5544.445555444443, 5571.8607034824045, 5625.831225063234, 5537.944620553783, 5539.750711217985, 5554.1113421852515, 5557.055300598888, 5564.527015203692, 4606.286025666027, 5530.778768849262, 5615.943840561583, 5616.494515493584, 5622.606417550773, 5449.455054494559, 5511.834644960618, 5533.861653458655, 5598.300212473441, 5614.326280846284, 4870.245112007645, 5772.422757724194, 5835.649861008353, 6054.364291749347, 6078.483328917047, 6353.332900045475, 6404.583702059351, 6422.614643121427, 6433.163688720483, 6437.935620643781, 5505.009098362293, 6465.515086368494, 6495.6752162391695, 6509.316521765194, 6547.770828021044, 6100.938990610126, 6121.5139442231075, 6125.357545073043, 6205.6586887721605, 6246.312905580383, 6575.473962083021, 6599.769008084694, 6632.900506492407, 6634.535582509275, 6648.102506161703, 6319.715612797435, 6331.588446750947, 6334.683265836689, 6354.777582784581, 6355.332690067568, 5362.597805164628, 6410.166678331787, 6487.22153341602, 6523.608583484911, 6525.738970441129, 5305.602079844027, 6312.116303717483, 6346.746130154742, 6362.077498762654, 6378.936210637927, 6258.780942666985, 6344.175257216532, 6364.363563643691, 6368.331325210879, 6387.904181437282, 5070.366204224472, 5166.819161329336, 5176.637635365489, 5180.766865491062, 5204.34945631796, 4633.119707255611, 4678.532146785362, 4692.366530518405, 4693.131770622445, 4695.85912422621, 6090.573659843857, 6133.6319820810895, 6165.260168779775, 6197.101420294032, 6215.782447614311, 5684.033714268584, 6331.366863313724, 6417.358264173546, 6487.870242595121, 6558.278589355167, 6211.3478084800445, 6211.440970312694, 6219.751209951552, 6222.906656400158, 6242.937570624326, 5613.186088017214, 5693.886122277531, 5763.6541807491685, 5764.0, 5768.3654797972185, 6716.697748601325, 6723.66381680914, 6726.192856857208, 6727.0, 6730.798076057726, 6495.480361571157, 6507.316731743288, 6508.9349106508325, 6513.641749703622, 6517.543771935919, 5604.943950560605, 6560.671966401756, 6732.798016059526, 6764.797056088325, 6811.625360605214, 4787.880302992453, 6350.174477317919, 6381.074744162163, 6395.552311338161, 6395.552311338348, 5476.6166368355425, 6429.54993150475, 6438.259600146043, 6455.838604034937, 6486.2216534016225, 5882.647041177543, 6276.1213430118905, 6302.558820882494, 6329.30377658448, 6346.048092786119, 6224.377562243921, 6290.24517057956, 6307.621542707452, 6310.021946598285, 6317.368263173646, 5181.404138524118, 6126.203593532812, 6200.875982480416, 6256.906146407717, 6258.499320054476, 5369.624126311277, 6276.748930042747, 6333.113364129118, 6337.144485494399, 6353.809385718436, 6234.657093859882, 6250.9062364065485, 6256.749730010749, 6262.2172228471445, 6275.6548389839], "value": 5910.791507571239, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.6109570561343, 541.1179776963548, 541.8997485465189, 608.5314307982853, 620.032748911698, 37406.62593374065, 38722.80638596803, 38770.0, 38868.80565597175, 38884.99999999996, 34359.0, 41184.38223426651, 41358.793206034, 41386.96532586679, 41525.0, 9567.856482152773, 9743.902560974371, 9772.21822254218, 9779.511024448784, 9800.411975281506, 9707.369021013646, 9768.51157442125, 9859.457729824857, 9869.555869985832, 9910.504474776268, 9923.0, 9929.652462163825, 9956.6515171969, 10017.198624110053, 10056.949715251414, 9915.504224788732, 9922.057404546593, 9970.850437243447, 9973.900260997407, 9996.95001524995, 9782.266330025277, 9818.9509052455, 9868.950655246677, 9928.50357482123, 9936.602535898555, 38860.417093743614, 39124.80437597794, 39300.60699393027, 39579.60420395788, 39658.40512392316, 3287.901362959115, 3387.627360990289, 3494.668006539375, 3800.4299355096955, 3985.0236692010353, 23723.16968906097, 28095.719042809516, 28425.43149137006, 28499.860005599752, 28579.0, 2371.466420055474, 2744.972550274492, 2787.0, 2795.622590950216, 2833.263351528597, 442764.0, 443073.0, 446412.0, 449295.0, 450849.0, 37144.0, 60877.0, 61328.0, 61329.693351533846, 61337.079943800876, 30370.0, 36057.098572535375, 36169.457458138146, 36313.818430907675, 36431.4535281971, 16231.675366492604, 16261.430849920196, 16380.26288817006, 16414.26135823891, 16440.83559164417, 13661.043726939019, 13729.0, 13740.175589464665, 13794.793078103836, 13850.584482465341, 8296.294814940798, 8322.6670933162, 8326.66693332272, 8335.791605209919, 8393.24460798531, 3225.419544423216, 3487.3548393546766, 3530.899115026555, 3570.1967057411875, 3587.8564857405413, 917.7797328641078, 1028.2082796246848, 1033.9896601034043, 1051.7738686182354, 1178.7878181927165, 30452.70768188991, 30477.23806904801, 30582.08253752391, 30699.2325191872, 30754.0, 1168.3574034281282, 1169.2867350915935, 1172.876847930955, 1194.811162892927, 1231.4335405713293, 15472.845271547141, 15491.147986860831, 15570.455034073753, 15687.764683529756, 15757.369705211662, 620144.0, 621959.0, 622302.0, 625361.0, 626098.0, 59472.0, 60189.69905150534, 60697.39302607006, 60718.0, 61070.694646526485, 1528.7936128622493, 1540.468538354266, 1544.2433207728357, 1573.3549244809574, 1629.4541328655034, 29848.403031939673, 29937.850310749178, 29953.101406957827, 30462.390752185274, 30597.08208753741, 50720.492795073056, 51132.74433627808, 51157.721056973875, 51456.0, 51803.74098129485, 545300.2734986299, 549058.0, 551588.0, 553261.0, 554835.0, 26704.599431008162, 26987.865060674572, 27074.0, 27114.32214194582, 27549.0, 46795.0, 46983.06033879235, 47248.527514725785, 47798.80502987453, 48266.55200343995, 38589.84230472978, 38680.6131938677, 38759.0, 39323.410148848365, 39338.40992385174, 36068.55725771045, 38266.23467530689, 38366.80816595899, 38426.807865960494, 38866.805665971486, 32988.84539041122, 37760.0, 38440.0, 39075.0, 39733.60266397415, 31829.522557162123, 31956.8402157997, 32105.0, 32164.19589510281, 32355.352892941537, 24840.0, 24883.129090481747, 24919.750802491744, 25238.49523009566, 25240.242792716246], "value": 18870.072774631666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.53460124660364, 419.52593569266725, 420.49960546949137, 428.86490755412046, 432.86797526754344, 21113.68329475057, 21296.0, 21512.677309840346, 22500.662490062663, 23069.884650576725, 22395.55208895821, 22431.32706018818, 22553.436164095907, 22704.65943010852, 22968.196113136044, 5250.763715632796, 6185.783497577586, 6260.874782504347, 6284.088807122965, 6310.810675679737, 4557.772111394417, 5815.621984570989, 6302.810915672537, 6569.277379488252, 6925.099737034204, 6798.830029249259, 6855.177378714561, 6860.382565569098, 6878.0, 6884.0362349271145, 6544.738210471575, 6774.932250677529, 6793.388595026471, 6796.320367963189, 6818.454523638122, 5900.1739756434135, 5956.612820166675, 5961.076033214858, 5970.432808883149, 5970.492508136814, 22370.44073898149, 26697.0, 27132.59301110485, 27250.727492725215, 27299.181024569294, 1721.397510871185, 2205.2061257947125, 2259.107652477279, 2358.7995020423286, 2850.957235641467, 15130.394784208618, 15244.314005869763, 15313.468653134709, 15633.687326253412, 16124.355025798954, 1813.3200049981258, 1843.308769196974, 1871.0364162456347, 1872.3353209610664, 1926.1524929031182, 110622.0, 112305.0, 113411.0, 113947.0, 114510.28234576488, 11686.94156529212, 11822.113341499422, 11878.0, 12007.579734709243, 12008.159428840072, 14748.778768318483, 14940.028898121587, 14947.626309342353, 15021.248937553079, 15058.472953446577, 9403.059694030679, 9432.434053956784, 9471.147596716191, 9541.856872146924, 9566.712998610054, 7821.217878212134, 9449.43303401798, 9543.952280238555, 9589.952050239704, 9608.471534065553, 7354.852902942018, 7356.301151390609, 7358.558486490828, 7378.262173782686, 7525.962370188224, 1957.8531610129298, 2017.0, 2080.521480059595, 2094.6962690409805, 2133.7012818205462, 936.5644975086482, 995.6067353395368, 1022.3763504262394, 1044.329073482422, 1096.572336788653, 21013.474663133544, 21837.908104595026, 21860.45348866259, 22092.558148837255, 22335.3299401015, 897.6858099665066, 1029.8867124616286, 1040.7502199472071, 1043.5095505112586, 1083.8916108389099, 10907.83638245427, 11223.933726295989, 11340.659780206606, 11350.0, 11360.829587556193, 645528.0, 646264.0, 680215.0, 693058.0, 697510.0, 116838.0, 142344.57655423522, 144485.0, 146124.26937865242, 147548.26225869017, 1081.4808891732014, 1101.2951710904867, 1103.812351900179, 1109.2180013090751, 1109.628274528026, 18447.907760461112, 18718.719219211995, 18850.71723924115, 18882.67821252554, 19002.049897504792, 53927.0, 54029.45970540244, 54046.729766350916, 54608.634784130714, 55748.42267375525, 82996.0, 84563.5771821137, 84781.0, 84955.0, 85777.57111214654, 7380.704771809283, 7402.9629851850395, 8491.957540212507, 8503.1921967413, 8849.734507964771, 8901.198892099743, 9788.0, 11865.822012669989, 13200.405981731037, 13741.931290343484, 5517.089680202722, 6109.877802444015, 11553.267009948575, 11595.536178552764, 12019.278843269432, 11338.716532086433, 11427.60003399877, 11525.596604118815, 11593.362365069665, 11687.649370518899, 11802.409879506162, 11827.349495777471, 11972.940135299268, 12114.394280286127, 12195.451204695633, 8539.701110461105, 8555.871661924952, 8568.35737319691, 8622.655093796178, 8690.391672582859, 8580.418433335328, 11658.6502404928, 11743.823842642538, 11833.526658933546, 11834.46744896499], "value": 10264.102307491197, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.866452019318, 1640.983590164098, 1856.7307740377646, 1971.0, 1979.5941831924456, 8404.0, 9067.501287429188, 9160.26717862571, 9372.531373431326, 9387.577559009844, 9032.367734258605, 9078.727638170849, 9202.987671356163, 9211.309151813608, 9216.032316606743, 2269.8083506159232, 2521.2436269119285, 2557.4373637799654, 2573.0, 2575.8454492730402, 2487.56467618167, 2566.6278389633494, 2587.7024142223695, 2588.094167041539, 2600.687917449899, 2548.528522223385, 2569.79441644668, 2586.9611955820583, 2590.5984572391217, 2632.4340266842623, 2544.847309161447, 2568.550503661861, 2570.961435578468, 2578.755018273261, 2587.443699604575, 2541.0471073347494, 2574.0604679291923, 2584.862660429405, 2587.2109006752935, 2594.7534984176473, 9115.817683646355, 9288.442693438348, 9335.206507446876, 9346.299027572892, 9370.812583748288, 5664.49019588239, 5699.515541179005, 5701.059325211335, 5856.560757943172, 5906.379830117861, 3620.7827530348, 3783.5459744830523, 3794.9810250948844, 3798.16440383118, 3826.081740382316, 1061.9522121504551, 1081.9513121909454, 1089.3028461784463, 1102.063246240697, 1124.3591153042769, 12533.498660053678, 12552.937235313764, 12626.873731262662, 12635.747285054247, 12655.493780248778, 5049.394072711299, 5096.898062038813, 5129.1793313070475, 5170.095233334151, 5193.480651934777, 10665.0, 10712.46437678113, 10722.678319650424, 10734.731631709114, 10740.462976851126, 5757.539396848242, 5832.504237139806, 5836.037053886062, 5854.853628659318, 5863.882722345529, 4630.930536041962, 5078.7206703631655, 5138.794448222104, 5143.17709166539, 5215.608829337815, 4237.745735255895, 4310.913781724411, 4324.372965919924, 4411.580899814512, 4412.271975124133, 1410.3230449384148, 1421.8649228323293, 1447.0666420158939, 1453.9345729441989, 1465.4504560789703, 937.6999360204805, 938.6714649872627, 944.7449188719007, 960.9231261499203, 975.4342481360935, 5976.701164941735, 6072.969635151796, 6232.657203853741, 6245.6252624842655, 6254.312025677263, 481.9253015782559, 489.89222371078307, 492.72899905052077, 1054.8312270036756, 1063.2557209953063, 4013.3578627420056, 4052.149048699806, 4067.2882245607493, 4099.9180016399505, 4111.054457474797, 10912.0, 11325.886741132648, 11400.486978086006, 11507.194496385173, 11529.654110376701, 9127.543622818832, 9542.3320367575, 10215.23385746072, 10283.9485802572, 11050.889491105147, 8626.439281446686, 8801.47191168532, 8823.647054117764, 8825.205731484197, 8847.513386763661, 5277.868053298698, 5846.766129354778, 5914.674692891932, 6116.5412594056515, 6119.510439164767, 9895.455749933823, 9947.900520994697, 9962.153216976638, 10251.58993640246, 10345.275830691779, 9933.205343572641, 10274.486275686037, 10286.742831429274, 10536.631217907336, 10543.472826358804, 7189.676464559003, 7694.4229182810395, 7768.067831860213, 7883.684652614061, 7946.046474423106, 8549.87175192385, 8753.78115547091, 8815.955920220358, 8833.381663283508, 8872.778180545538, 7621.428392870446, 7736.187700291388, 7749.031371078615, 7840.686372545034, 7880.487768295043, 7590.696372145052, 7594.278543538355, 7598.810029749079, 7636.12184598756, 7764.689412423666, 7352.191258961617, 7442.851142977219, 7445.516041457288, 7468.887966680395, 7476.476646634684, 4988.176950803077, 5016.247562865599, 5160.045391602565, 5203.713795741271, 5207.92188117171, 5162.870928226825, 5174.404943431554, 5240.790368385222, 5395.352557692945, 5418.891622167614], "value": 4817.687368403755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.86932922837025, 320.383262220226, 343.2705500810778, 343.9776414533055, 346.7122288500545, 6642.568233064848, 6699.464042876571, 6813.28460511646, 6855.520113592044, 6874.243833178352, 6792.626405547693, 6848.4178844798125, 6848.863022739542, 6889.689963951621, 6912.619805910673, 5031.371078615173, 5047.369078865142, 5048.192289233723, 5067.8479645610505, 5093.134167191568, 5079.74601269935, 5081.974590127063, 5092.8472145835685, 5101.464346243647, 5105.8767071244265, 5005.54950054495, 5005.799768009293, 5008.724520151391, 5034.798608055673, 5036.194208926572, 4829.720124167098, 4936.925946110811, 5011.574016208627, 5025.849224523252, 5042.722650254234, 3363.6131844837914, 4271.508776490712, 4283.97858010711, 4298.591633794816, 4298.677599180042, 6563.113979612786, 6584.275729669733, 6590.769323073718, 6598.241202261754, 6608.0418339341, 5943.3165186003735, 5962.761489540413, 5964.791232306892, 5978.44560414291, 5984.760609575612, 5825.83483303341, 7133.92866071343, 7346.522476039094, 7377.225391333886, 7385.66764495599, 4524.932126018112, 4677.929831052537, 4691.62467002639, 4777.570018698334, 4789.56893879549, 7717.151113377524, 7757.1854955229455, 7789.766307010798, 7793.376529877596, 7830.6084695764985, 4776.498467660915, 4783.1390349737385, 4785.1625965455905, 4790.850195952946, 4800.975995120002, 4879.170541008037, 4882.292067650171, 4886.828960986349, 4905.2151655734915, 4926.211806111077, 4795.520447955177, 5898.4101589840675, 5898.911516327258, 5901.616394934315, 5926.525877929756, 5918.852028699317, 7133.714651413885, 7399.334059934632, 7439.0, 7442.292982166686, 1334.292824802856, 1449.9565013049626, 1613.3062783003422, 1613.628415846521, 1672.9414470493475, 995.1342332170913, 1040.5317607076845, 1052.5105825791045, 1065.8880817514205, 1068.7274744939991, 6399.360063993657, 6728.764493242811, 6906.37842594169, 6940.305969403019, 6950.200726916368, 7004.2645522220455, 7699.422543309274, 7700.152983171846, 7702.229777022253, 7729.381649468029, 6870.656467176721, 6905.861882762317, 6911.6544172791155, 6914.101166848278, 6929.376356127973, 3448.413769659164, 3804.6195380462286, 4036.414719865662, 4071.226466971266, 4076.898077548085, 8021.7994550135545, 8071.4349995500925, 8073.434859559775, 8094.676212951534, 8115.79710507242, 7886.960565197137, 7945.761627151194, 7958.6418611162635, 7972.123066462685, 7973.800654983555, 8015.238552337519, 8051.194880512019, 8082.353411727047, 8088.4742491739025, 8094.919050809534, 7344.632768361454, 7617.047869016373, 7637.961810191136, 7678.308952194329, 7711.575863327571, 7505.662245199088, 7547.50941188821, 7548.811279718051, 7573.242675732383, 7598.012258406372, 6411.93588064132, 8024.638891249791, 8042.276195142465, 8062.516249024842, 8069.556174410229, 4642.791074401593, 4760.857174284777, 4814.542618451242, 4821.300911367902, 4821.325014498043, 6263.0, 7260.528065675714, 7658.655360508902, 7667.271609197117, 7673.577953212627, 6625.873601487662, 7353.0, 7367.631618419165, 7389.150247721581, 7389.261073892568, 6745.392914637706, 7340.11918569775, 7341.449391295568, 7355.485116041826, 7357.668904899186, 7153.82115447118, 7155.8568828624175, 7163.391111755559, 7188.317109874553, 7214.2785721427435, 7172.211056783645, 7403.629818508945, 7478.925210748041, 7482.176960534228, 7488.101427828696, 6914.792556223321, 7020.946857971345, 7142.428605711634, 7171.713131474683, 7212.3148300911325], "value": 5319.581177805353, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.702629764011, 663.0783211336246, 771.4291424345982, 786.3119770201074, 791.5171745235409, 11782.410879456025, 13383.732325353487, 15363.15502647354, 15673.608159795996, 15696.921515392421, 14052.0, 14220.71558568828, 14539.49111781088, 14627.049241799275, 14662.12027278364, 778.3811869563682, 937.8030613571158, 948.8481842905119, 958.712386284112, 970.776721354089, 929.5770424456856, 944.1691311645742, 946.517276189145, 947.5783276441986, 949.2074118111385, 1019.7603563162688, 1024.0629823711295, 1026.153423425673, 1027.7995790820794, 1028.300755486269, 1010.9241806864478, 1011.7622358745689, 1012.4330374990029, 1016.217512515359, 1018.974525636865, 733.2410954661899, 747.7382915979418, 760.5132715062365, 761.0220866186978, 762.4319881688123, 15183.240837958168, 15240.923795381063, 15258.313375898111, 15405.691886162325, 15471.303791329417, 12854.0, 12893.613191604267, 12973.378327709037, 13059.608211753663, 13208.405621746948, 10039.901536506897, 10187.981201879827, 10323.690289291333, 10353.637622683245, 10544.841827372518, 3600.837962291703, 3855.363864962306, 4114.403411505315, 4122.855700050513, 4398.73607583546, 85422.14577854204, 86139.0, 86220.0, 89499.55250223707, 89810.55094724485, 9608.711738647851, 9696.51517424126, 9875.012498750211, 9915.256355773201, 10005.699829005142, 21506.784932150793, 21709.782902170777, 21827.345179644635, 21909.452263693536, 21976.34070977873, 7614.619269036526, 7783.0, 7790.220977902278, 7791.376689864911, 7882.408819338572, 4165.062860856283, 4179.2059508693255, 4204.033072393367, 4211.410402543646, 4212.831486740557, 3741.663250307431, 3801.5248093988253, 3828.272628200633, 3834.2331533692814, 3836.1752223271574, 673.0980486148584, 686.9381755642016, 689.2074114768056, 692.1693967239333, 696.2584847137782, 488.9584385327216, 491.3538696613941, 577.8873119741694, 591.030709636197, 604.099891162174, 6224.0, 7104.396126329217, 7827.099883513469, 7918.287354138155, 8155.34757219421, 568.9857753556195, 579.9101139323411, 612.3447910735559, 613.7759717703007, 621.2141640824361, 3616.0, 3756.4553139794575, 3777.7355585109326, 3785.962140378616, 3827.8660246891227, 86866.0, 87072.5646371764, 87646.0, 89013.10986890178, 89399.21201575932, 80036.39927201423, 80663.59668201621, 81021.18978810136, 81108.59445702734, 81346.77979830308, 72187.6390618054, 72796.63601681958, 73060.63469682618, 73981.63009185027, 74135.62932185413, 6878.7248510059035, 7077.150741911004, 7434.5167564110325, 7496.325330720261, 7674.6930122794465, 49614.50385496099, 49781.00437991292, 50213.74893125511, 50320.46474887832, 52540.0, 61518.0, 68188.6590567044, 68355.0, 69192.6540367295, 70661.23346916368, 8322.875156872773, 9853.0, 9879.0, 9895.950520247352, 10812.621558245424, 11928.403579821148, 12157.1489995703, 12171.81742273849, 12253.448594813433, 12626.494940202288, 11419.771604567695, 11483.36841473727, 11560.30638161713, 11560.959513643813, 11990.220635658654, 11170.050545703707, 11370.374629395132, 11469.541218351173, 11502.769944601228, 11692.298462092302, 9206.447613143233, 11202.59319286872, 11319.037881780141, 11489.712757180803, 11671.066314694974, 9268.58291376903, 9313.534323283673, 9477.668281610111, 9677.274204434554, 9755.804883902425, 9663.371880828005, 9740.464274464972, 9773.315867889463, 9797.97121302253, 9852.507374631383], "value": 6998.289633937482, "unit": "score"}], "name": "dromaeo_css", "value": 7680.926161319768, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 117.0, 117.0, 117.0, 132.0, 116.0, 111.0, 113.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 143.0, 151.0, 119.0, 144.0, 140.0, 109.0, 204.0, 143.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 200.0, 198.0, 199.0, 198.0, 193.0, 201.0, 202.0, 199.0, 195.0], "value": 198.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 82.0, 74.0, 143.0, 58.0, 57.0, 56.0, 64.0, 125.0, 55.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 124.0, 75.0, 78.0, 84.0, 120.0, 85.0, 110.0, 154.0], "value": 98.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 88.0, 130.0, 85.0, 92.0, 86.0, 89.0, 85.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 113.0, 149.0, 125.0, 94.0, 117.0, 115.0, 95.0, 93.0, 95.0], "value": 109.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 91.0, 88.0, 91.0, 88.0, 99.0, 129.0, 88.0, 90.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 64.0, 64.0, 64.0, 74.0, 93.0, 108.0, 94.0, 82.0], "value": 76.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 66.0, 87.0, 95.0, 98.0, 73.0, 70.0, 85.0, 66.0, 66.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 102.0, 99.0, 88.0, 80.0, 77.0, 86.0, 101.0, 99.0, 106.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 141.0, 140.0, 116.0, 152.0, 146.0, 149.0, 147.0, 141.0, 139.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 176.0, 165.0, 162.0, 167.0, 172.0, 164.0, 167.0, 162.0, 161.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 70.0, 65.0, 65.0, 68.0, 67.0, 70.0, 68.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1547.5, "alertThreshold": 2.0}]} 13:29:54 INFO - Return code: 0 13:29:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:29:54 ERROR - # TBPL SUCCESS # 13:29:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:29:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:29:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:29:54 INFO - 2016-07-16 13:29:54.414 screenresolution[1822:10576] starting screenresolution argv=screenresolution get 13:29:54 INFO - 2016-07-16 13:29:54.417 screenresolution[1822:10576] Display 0: 1600x1200x32@60 13:29:54 INFO - 2016-07-16 13:29:54.422 screenresolution[1823:10579] starting screenresolution argv=screenresolution list 13:29:54 INFO - Available Modes on Display 0 13:29:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:29:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:29:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:29:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:29:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:29:54 INFO - Intel Iris: 13:29:54 INFO - Chipset Model: Intel Iris 13:29:54 INFO - Type: GPU 13:29:54 INFO - Bus: Built-In 13:29:54 INFO - VRAM (Dynamic, Max): 1536 MB 13:29:54 INFO - Vendor: Intel (0x8086) 13:29:54 INFO - Device ID: 0x0a2e 13:29:54 INFO - Revision ID: 0x0009 13:29:54 INFO - Displays: 13:29:54 INFO - Display: 13:29:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:29:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:29:54 INFO - Display Serial Number: 1600x1200 60 13:29:54 INFO - Main Display: Yes 13:29:54 INFO - Mirror: Off 13:29:54 INFO - Online: Yes 13:29:54 INFO - Rotation: Supported 13:29:54 INFO - Return code: 0 13:29:54 INFO - Running post-action listener: _resource_record_post_action 13:29:54 INFO - Running post-run listener: _resource_record_post_run 13:29:55 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 37012992; Write bytes: 497211904; Read time: 240; Write time: 1623 13:29:55 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 200243712; Write bytes: 194670592; Read time: 17724; Write time: 430 13:29:55 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 29892096; Write bytes: 301693440; Read time: 182; Write time: 1190 13:29:55 INFO - Running post-run listener: _upload_blobber_files 13:29:55 INFO - Blob upload gear active. 13:29:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:55 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 13:29:55 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'] 13:29:55 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 13:29:56 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:57 INFO - (blobuploader) - INFO - Done attempting. 13:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:29:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:58 INFO - (blobuploader) - INFO - Done attempting. 13:29:58 INFO - (blobuploader) - INFO - Iteration through files over. 13:29:58 INFO - Return code: 0 13:29:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:29:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:29:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83a9c3d604c9b4e876a48bd3ec5fdb8876cc701222bd8f364bcd9b40af058fa6d946ccdb4095f1bc92c8c088a87d494ea40fb9e4072bc41764a718cdd6f65ffe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4252569d1a0081dfa25d7f364c45dc4e974d1a8a1aa5c6d2c2c60a66cd9da3bb56b3d7b7609b8dc6f374a1e956107770809e6984218436a5b6f45be16d60849d"} 13:29:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:29:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:29:58 INFO - Contents: 13:29:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83a9c3d604c9b4e876a48bd3ec5fdb8876cc701222bd8f364bcd9b40af058fa6d946ccdb4095f1bc92c8c088a87d494ea40fb9e4072bc41764a718cdd6f65ffe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4252569d1a0081dfa25d7f364c45dc4e974d1a8a1aa5c6d2c2c60a66cd9da3bb56b3d7b7609b8dc6f374a1e956107770809e6984218436a5b6f45be16d60849d"} 13:29:58 INFO - Running post-run listener: copy_logs_to_upload_dir 13:29:58 INFO - Copying logs to upload dir... 13:29:58 INFO - mkdir: /builds/slave/test/build/upload/logs 13:29:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.257955 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-07-16 13:29:58.266140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 13:29:58.270061) ========= 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.QrspE2RtRF/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.eYiQUoFNjC/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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/83a9c3d604c9b4e876a48bd3ec5fdb8876cc701222bd8f364bcd9b40af058fa6d946ccdb4095f1bc92c8c088a87d494ea40fb9e4072bc41764a718cdd6f65ffe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4252569d1a0081dfa25d7f364c45dc4e974d1a8a1aa5c6d2c2c60a66cd9da3bb56b3d7b7609b8dc6f374a1e956107770809e6984218436a5b6f45be16d60849d"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011138 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468493218/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83a9c3d604c9b4e876a48bd3ec5fdb8876cc701222bd8f364bcd9b40af058fa6d946ccdb4095f1bc92c8c088a87d494ea40fb9e4072bc41764a718cdd6f65ffe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4252569d1a0081dfa25d7f364c45dc4e974d1a8a1aa5c6d2c2c60a66cd9da3bb56b3d7b7609b8dc6f374a1e956107770809e6984218436a5b6f45be16d60849d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 13:29:58.308128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:29:58.308699) ========= 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.QrspE2RtRF/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.eYiQUoFNjC/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.005168 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:29:58.358327) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 13:29:58.358647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 13:29:58.358980) ========= ========= Total master_lag: 0.28 =========