builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0280 starttime: 1468825156.56 results: success (0) buildid: 20160716031557 builduid: b362da397c6c493ca5cb410c272af1bf revision: 24af5e8917a2a3efabc8f1c614c709282fc2d473 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:16.557680) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:16.558168) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:16.558509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:16.585495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:16.585855) ========= 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.ShkImyusqo/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.OrJ2y269I0/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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-17 23:59:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 67.7M=0s 2016-07-17 23:59:17 (67.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.585310 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:17.203218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:17.203552) ========= 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.ShkImyusqo/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.OrJ2y269I0/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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.020454 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:17.293447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-17 23:59:17.293809) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 24af5e8917a2a3efabc8f1c614c709282fc2d473 --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 24af5e8917a2a3efabc8f1c614c709282fc2d473 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ShkImyusqo/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.OrJ2y269I0/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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-17 23:59:17,376 truncating revision to first 12 chars 2016-07-17 23:59:17,376 Setting DEBUG logging. 2016-07-17 23:59:17,376 attempt 1/10 2016-07-17 23:59:17,376 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/24af5e8917a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 23:59:19,027 unpacking tar archive at: mozilla-beta-24af5e8917a2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.939109 ========= master_lag: 1.48 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-17 23:59:20.713844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:20.714130) ========= script_repo_revision: 24af5e8917a2a3efabc8f1c614c709282fc2d473 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:20.714527) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:20.714826) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 23:59:21.569666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-17 23:59:21.570034) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ShkImyusqo/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.OrJ2y269I0/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 23:59:21 INFO - MultiFileLogger online at 20160717 23:59:21 in /builds/slave/test 23:59:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:59:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:59:21 INFO - {'append_to_log': False, 23:59:21 INFO - 'base_work_dir': '/builds/slave/test', 23:59:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:59:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:59:21 INFO - 'branch': 'Mozilla-Beta', 23:59:21 INFO - 'buildbot_json_path': 'buildprops.json', 23:59:21 INFO - 'config_files': ('talos/mac_config.py',), 23:59:21 INFO - 'default_actions': ('clobber', 23:59:21 INFO - 'read-buildbot-config', 23:59:21 INFO - 'download-and-extract', 23:59:21 INFO - 'populate-webroot', 23:59:21 INFO - 'create-virtualenv', 23:59:21 INFO - 'install', 23:59:21 INFO - 'run-tests'), 23:59:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:59:21 INFO - 'download_minidump_stackwalk': True, 23:59:21 INFO - 'download_symbols': 'ondemand', 23:59:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:59:21 INFO - 'tooltool.py': '/tools/tooltool.py', 23:59:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:59:21 INFO - '/tools/misc-python/virtualenv.py')}, 23:59:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:59:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:59:21 INFO - 'installer_path': 'installer.exe', 23:59:21 INFO - 'log_level': 'info', 23:59:21 INFO - 'log_name': 'talos', 23:59:21 INFO - 'log_to_console': True, 23:59:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:59:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:59:21 INFO - 'opt_config_files': (), 23:59:21 INFO - 'pip_index': False, 23:59:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:59:21 INFO - 'cmd': ('bash', 23:59:21 INFO - '-c', 23:59:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:59:21 INFO - 'enabled': True, 23:59:21 INFO - 'halt_on_failure': False, 23:59:21 INFO - 'name': 'check_screen_resolution'},), 23:59:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:59:21 INFO - 'cmd': ('bash', 23:59:21 INFO - '-c', 23:59:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:59:21 INFO - 'enabled': True, 23:59:21 INFO - 'halt_on_failure': False, 23:59:21 INFO - 'name': 'check_screen_resolution'},), 23:59:21 INFO - 'run_cmd_checks_enabled': True, 23:59:21 INFO - 'sps_profile': False, 23:59:21 INFO - 'sps_profile_interval': 0, 23:59:21 INFO - 'suite': 'dromaeojs', 23:59:21 INFO - 'system_bits': '32', 23:59:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:59:21 INFO - 'title': 't-yosemite-r7-0280', 23:59:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:59:21 INFO - 'use_talos_json': True, 23:59:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:59:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:59:21 INFO - 'work_dir': 'build'} 23:59:21 INFO - ##### 23:59:21 INFO - ##### Running clobber step. 23:59:21 INFO - ##### 23:59:21 INFO - Running pre-action listener: _resource_record_pre_action 23:59:21 INFO - Running main action method: clobber 23:59:21 INFO - rmtree: /builds/slave/test/build 23:59:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:59:22 INFO - Running post-action listener: _resource_record_post_action 23:59:22 INFO - ##### 23:59:22 INFO - ##### Running read-buildbot-config step. 23:59:22 INFO - ##### 23:59:22 INFO - Running pre-action listener: _resource_record_pre_action 23:59:22 INFO - Running main action method: read_buildbot_config 23:59:22 INFO - Using buildbot properties: 23:59:22 INFO - { 23:59:22 INFO - "project": "", 23:59:22 INFO - "product": "firefox", 23:59:22 INFO - "script_repo_revision": "production", 23:59:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 23:59:22 INFO - "repository": "", 23:59:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 23:59:22 INFO - "buildid": "20160716031557", 23:59:22 INFO - "pgo_build": "False", 23:59:22 INFO - "basedir": "/builds/slave/test", 23:59:22 INFO - "buildnumber": 46, 23:59:22 INFO - "slavename": "t-yosemite-r7-0280", 23:59:22 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 23:59:22 INFO - "platform": "yosemite_r7", 23:59:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 23:59:22 INFO - "branch": "mozilla-beta", 23:59:22 INFO - "repo_path": "releases/mozilla-beta", 23:59:22 INFO - "revision": "24af5e8917a2a3efabc8f1c614c709282fc2d473", 23:59:22 INFO - "stage_platform": "macosx64", 23:59:22 INFO - "builduid": "b362da397c6c493ca5cb410c272af1bf", 23:59:22 INFO - "slavebuilddir": "test" 23:59:22 INFO - } 23:59:22 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.dmg. 23:59:22 INFO - Running post-action listener: _resource_record_post_action 23:59:22 INFO - ##### 23:59:22 INFO - ##### Running download-and-extract step. 23:59:22 INFO - ##### 23:59:22 INFO - Running pre-action listener: _resource_record_pre_action 23:59:22 INFO - Running main action method: download_and_extract 23:59:22 INFO - mkdir: /builds/slave/test/build/tests 23:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.test_packages.json 23:59:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 23:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/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 23:59:22 INFO - Downloaded 1165 bytes. 23:59:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 23:59:22 INFO - Using the following test package requirements: 23:59:22 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 23:59:22 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:59:22 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 23:59:22 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:59:22 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 23:59:22 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 23:59:22 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:59:22 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 23:59:22 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 23:59:22 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:59:22 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 23:59:22 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:59:22 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 23:59:22 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:59:22 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 23:59:22 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:59:22 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 23:59:22 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 23:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.common.tests.zip 23:59:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 23:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/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 23:59:23 INFO - Downloaded 18314874 bytes. 23:59:23 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'] 23:59:23 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 23:59:26 INFO - Return code: 0 23:59:26 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 23:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.common.tests.zip 23:59:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 23:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/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 23:59:26 INFO - Downloaded 18314874 bytes. 23:59:26 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'] 23:59:26 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 23:59:30 INFO - Return code: 0 23:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.talos.tests.zip 23:59:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 23:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/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 23:59:30 INFO - Downloaded 10840145 bytes. 23:59:30 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'] 23:59:30 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 23:59:30 INFO - Return code: 0 23:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.dmg 23:59:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 23:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 23:59:33 INFO - Downloaded 86188885 bytes. 23:59:33 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.dmg 23:59:33 INFO - mkdir: /builds/slave/test/properties 23:59:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:59:33 INFO - Writing to file /builds/slave/test/properties/build_url 23:59:33 INFO - Contents: 23:59:33 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.dmg 23:59:33 INFO - Running post-action listener: _resource_record_post_action 23:59:33 INFO - Running post-action listener: set_extra_try_arguments 23:59:33 INFO - ##### 23:59:33 INFO - ##### Running populate-webroot step. 23:59:33 INFO - ##### 23:59:33 INFO - Running pre-action listener: _resource_record_pre_action 23:59:33 INFO - Running main action method: populate_webroot 23:59:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:59:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:59:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:59:33 INFO - '--tppagecycles', 23:59:33 INFO - '7'], 23:59:33 INFO - 'tests': ['tsvgm']}}, 23:59:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:59:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:59:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:59:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:59:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:59:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:59:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:33 INFO - 'talos_options': ['--disable-e10s'], 23:59:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:59:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:59:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:33 INFO - 'talos_options': ['--disable-e10s'], 23:59:33 INFO - 'tests': ['damp', 'tps']}, 23:59:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:33 INFO - 'tests': ['damp', 'tps']}, 23:59:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:59:33 INFO - 'tests': ['dromaeo_dom']}, 23:59:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:59:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:59:33 INFO - 'tests': ['a11yr', 23:59:33 INFO - 'ts_paint', 23:59:33 INFO - 'tpaint', 23:59:33 INFO - 'sessionrestore', 23:59:33 INFO - 'sessionrestore_no_auto_restore', 23:59:33 INFO - 'tabpaint']}, 23:59:33 INFO - 'other-e10s': {'tests': ['a11yr', 23:59:33 INFO - 'ts_paint', 23:59:33 INFO - 'tpaint', 23:59:33 INFO - 'sessionrestore', 23:59:33 INFO - 'sessionrestore_no_auto_restore', 23:59:33 INFO - 'tabpaint']}, 23:59:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:59:33 INFO - 'ts_paint', 23:59:33 INFO - 'tpaint', 23:59:33 INFO - 'sessionrestore', 23:59:33 INFO - 'sessionrestore_no_auto_restore', 23:59:33 INFO - 'tabpaint']}, 23:59:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:59:33 INFO - 'ts_paint', 23:59:33 INFO - 'tpaint', 23:59:33 INFO - 'sessionrestore', 23:59:33 INFO - 'sessionrestore_no_auto_restore', 23:59:33 INFO - 'tabpaint']}, 23:59:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:59:33 INFO - 'tests': ['a11yr', 23:59:33 INFO - 'ts_paint', 23:59:33 INFO - 'tpaint', 23:59:33 INFO - 'sessionrestore', 23:59:33 INFO - 'sessionrestore_no_auto_restore', 23:59:33 INFO - 'tabpaint']}, 23:59:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:59:33 INFO - 'tests': ['a11yr', 23:59:33 INFO - 'ts_paint', 23:59:33 INFO - 'tpaint', 23:59:33 INFO - 'sessionrestore', 23:59:33 INFO - 'sessionrestore_no_auto_restore', 23:59:33 INFO - 'tabpaint']}, 23:59:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:59:33 INFO - 'tests': ['tsvgx', 23:59:33 INFO - 'tsvgr_opacity', 23:59:33 INFO - 'tart', 23:59:33 INFO - 'tscrollx', 23:59:33 INFO - 'cart']}, 23:59:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:59:33 INFO - 'tsvgr_opacity', 23:59:33 INFO - 'tart', 23:59:33 INFO - 'tscrollx', 23:59:33 INFO - 'cart']}, 23:59:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:33 INFO - 'talos_options': ['--disable-e10s'], 23:59:33 INFO - 'tests': ['tp5o']}, 23:59:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:33 INFO - 'tests': ['tp5o']}, 23:59:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:33 INFO - 'talos_options': ['--disable-e10s', 23:59:33 INFO - '--xperf_path', 23:59:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:59:33 INFO - 'tests': ['tp5n']}, 23:59:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:33 INFO - 'talos_options': ['--xperf_path', 23:59:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:59:33 INFO - 'tests': ['tp5n']}}, 23:59:33 INFO - 'talos.zip': {'path': '', 23:59:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:59:33 INFO - Running post-action listener: _resource_record_post_action 23:59:33 INFO - ##### 23:59:33 INFO - ##### Running create-virtualenv step. 23:59:33 INFO - ##### 23:59:33 INFO - Running pre-action listener: _resource_record_pre_action 23:59:33 INFO - Running main action method: create_virtualenv 23:59:33 INFO - Creating virtualenv /builds/slave/test/build/venv 23:59:33 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 23:59:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:59:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:59:33 INFO - Using real prefix '/tools/python27' 23:59:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:59:34 INFO - Installing distribute.............................................................................................................................................................................................done. 23:59:37 INFO - Installing pip.................done. 23:59:37 INFO - Return code: 0 23:59:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:59:37 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')]} 23:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:37 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')]} 23:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:37 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 0x10907ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10908b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae0d88060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f1ae00>, '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 0x108d83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f15b20>, '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.ShkImyusqo/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.OrJ2y269I0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 23:59:37 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 23:59:37 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 23:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ShkImyusqo/Render', 23:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:37 INFO - 'HOME': '/Users/cltbld', 23:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:37 INFO - 'LOGNAME': 'cltbld', 23:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:37 INFO - 'MOZ_NO_REMOTE': '1', 23:59:37 INFO - 'NO_EM_RESTART': '1', 23:59:37 INFO - 'PAGER': '/bin/cat', 23:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:37 INFO - 'PWD': '/builds/slave/test', 23:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:37 INFO - 'SHELL': '/bin/bash', 23:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OrJ2y269I0/Listeners', 23:59:37 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 23:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:37 INFO - 'USER': 'cltbld', 23:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:37 INFO - 'XPC_FLAGS': '0x0', 23:59:37 INFO - 'XPC_SERVICE_NAME': '0', 23:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:37 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 23:59:37 INFO - Cleaning up... 23:59:37 INFO - Return code: 0 23:59:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:59:37 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')]} 23:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:37 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')]} 23:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:37 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 0x10907ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10908b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae0d88060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f1ae00>, '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 0x108d83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f15b20>, '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.ShkImyusqo/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.OrJ2y269I0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 23:59:37 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 23:59:37 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 23:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ShkImyusqo/Render', 23:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:37 INFO - 'HOME': '/Users/cltbld', 23:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:37 INFO - 'LOGNAME': 'cltbld', 23:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:37 INFO - 'MOZ_NO_REMOTE': '1', 23:59:37 INFO - 'NO_EM_RESTART': '1', 23:59:37 INFO - 'PAGER': '/bin/cat', 23:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:37 INFO - 'PWD': '/builds/slave/test', 23:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:37 INFO - 'SHELL': '/bin/bash', 23:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OrJ2y269I0/Listeners', 23:59:37 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 23:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:37 INFO - 'USER': 'cltbld', 23:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:37 INFO - 'XPC_FLAGS': '0x0', 23:59:37 INFO - 'XPC_SERVICE_NAME': '0', 23:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:37 INFO - Downloading/unpacking psutil>=0.7.1 23:59:37 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 23:59:37 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 23:59:37 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 23:59:37 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 23:59:37 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 23:59:37 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 23:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:59:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:59:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:59:41 INFO - Installing collected packages: psutil 23:59:41 INFO - Running setup.py install for psutil 23:59:41 INFO - building 'psutil._psutil_osx' extension 23:59:41 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 23:59:42 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 23:59:42 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 23:59:42 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 23:59:42 INFO - building 'psutil._psutil_posix' extension 23:59:42 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 23:59:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:59:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:59:42 INFO - ^ 23:59:42 INFO - 1 warning generated. 23:59:42 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 23:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:59:42 INFO - Successfully installed psutil 23:59:42 INFO - Cleaning up... 23:59:42 INFO - Return code: 0 23:59:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:59:42 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')]} 23:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:42 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')]} 23:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:42 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 0x10907ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10908b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae0d88060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f1ae00>, '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 0x108d83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f15b20>, '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.ShkImyusqo/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.OrJ2y269I0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 23:59:42 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 23:59:42 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 23:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ShkImyusqo/Render', 23:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:42 INFO - 'HOME': '/Users/cltbld', 23:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:42 INFO - 'LOGNAME': 'cltbld', 23:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:42 INFO - 'MOZ_NO_REMOTE': '1', 23:59:42 INFO - 'NO_EM_RESTART': '1', 23:59:42 INFO - 'PAGER': '/bin/cat', 23:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:42 INFO - 'PWD': '/builds/slave/test', 23:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:42 INFO - 'SHELL': '/bin/bash', 23:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OrJ2y269I0/Listeners', 23:59:42 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 23:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:42 INFO - 'USER': 'cltbld', 23:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:42 INFO - 'XPC_FLAGS': '0x0', 23:59:42 INFO - 'XPC_SERVICE_NAME': '0', 23:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:59: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 23:59: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 23:59: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 23:59: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 23:59: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 23:59: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 23:59:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:59:45 INFO - Installing collected packages: mozsystemmonitor 23:59:45 INFO - Running setup.py install for mozsystemmonitor 23:59:45 INFO - Successfully installed mozsystemmonitor 23:59:45 INFO - Cleaning up... 23:59:45 INFO - Return code: 0 23:59:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10907ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10908b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae0d88060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f1ae00>, '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 0x108d83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f15b20>, '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.ShkImyusqo/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.OrJ2y269I0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 23:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:59:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ShkImyusqo/Render', 23:59:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:45 INFO - 'HOME': '/Users/cltbld', 23:59:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:45 INFO - 'LOGNAME': 'cltbld', 23:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:45 INFO - 'MOZ_NO_REMOTE': '1', 23:59:45 INFO - 'NO_EM_RESTART': '1', 23:59:45 INFO - 'PAGER': '/bin/cat', 23:59:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:45 INFO - 'PWD': '/builds/slave/test', 23:59:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:45 INFO - 'SHELL': '/bin/bash', 23:59:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OrJ2y269I0/Listeners', 23:59:45 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 23:59:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:45 INFO - 'USER': 'cltbld', 23:59:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:45 INFO - 'XPC_FLAGS': '0x0', 23:59:45 INFO - 'XPC_SERVICE_NAME': '0', 23:59:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:46 INFO - Downloading/unpacking blobuploader==1.2.4 23:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:48 INFO - Downloading blobuploader-1.2.4.tar.gz 23:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:59:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:59:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:49 INFO - Downloading docopt-0.6.1.tar.gz 23:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:59:49 INFO - Installing collected packages: blobuploader, requests, docopt 23:59:49 INFO - Running setup.py install for blobuploader 23:59:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:59:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:59:49 INFO - Running setup.py install for requests 23:59:50 INFO - Running setup.py install for docopt 23:59:50 INFO - Successfully installed blobuploader requests docopt 23:59:50 INFO - Cleaning up... 23:59:50 INFO - Return code: 0 23:59:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:50 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 0x10907ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10908b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae0d88060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f1ae00>, '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 0x108d83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f15b20>, '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.ShkImyusqo/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.OrJ2y269I0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 23:59:50 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 23:59:50 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 23:59:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ShkImyusqo/Render', 23:59:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:50 INFO - 'HOME': '/Users/cltbld', 23:59:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:50 INFO - 'LOGNAME': 'cltbld', 23:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:50 INFO - 'MOZ_NO_REMOTE': '1', 23:59:50 INFO - 'NO_EM_RESTART': '1', 23:59:50 INFO - 'PAGER': '/bin/cat', 23:59:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:50 INFO - 'PWD': '/builds/slave/test', 23:59:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:50 INFO - 'SHELL': '/bin/bash', 23:59:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OrJ2y269I0/Listeners', 23:59:50 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 23:59:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:50 INFO - 'USER': 'cltbld', 23:59:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:50 INFO - 'XPC_FLAGS': '0x0', 23:59:50 INFO - 'XPC_SERVICE_NAME': '0', 23:59:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:59:50 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-eO8ghv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:59:51 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-IJQtVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:59:51 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-B9S_9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:59:51 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-YTNffL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:59:51 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-RlIRdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:59:51 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-MFySjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:59:51 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-dkzMEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:59:51 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-c9JvvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:59:51 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-5bT_PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:59:51 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-iTejOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:59:51 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-Xs5zc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:59:52 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-sJfORn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:59:52 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-5gbVi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:59:52 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-AD0LVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:52 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-hWJNMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:59:52 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-Gkxs0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:59:52 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-z_9l4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:59:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:59:52 INFO - Running setup.py install for manifestparser 23:59:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:59:52 INFO - Running setup.py install for mozcrash 23:59:52 INFO - Running setup.py install for mozdebug 23:59:53 INFO - Running setup.py install for mozdevice 23:59:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:59:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:59:53 INFO - Running setup.py install for mozfile 23:59:53 INFO - Running setup.py install for mozhttpd 23:59:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:59:53 INFO - Running setup.py install for mozinfo 23:59:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:59:53 INFO - Running setup.py install for mozInstall 23:59:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:59:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:59:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:59:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:59:53 INFO - Running setup.py install for mozleak 23:59:54 INFO - Running setup.py install for mozlog 23:59:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:59:54 INFO - Running setup.py install for moznetwork 23:59:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:59:54 INFO - Running setup.py install for mozprocess 23:59:54 INFO - Running setup.py install for mozprofile 23:59:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:59:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:59:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:59:54 INFO - Running setup.py install for mozrunner 23:59:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:59:54 INFO - Running setup.py install for mozscreenshot 23:59:54 INFO - Running setup.py install for moztest 23:59:55 INFO - Running setup.py install for mozversion 23:59:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:59:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:59:55 INFO - Cleaning up... 23:59:55 INFO - Return code: 0 23:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:59:55 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')]} 23:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:55 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')]} 23:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:55 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 0x10907ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10908b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae0d88060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f1ae00>, '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 0x108d83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f15b20>, '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.ShkImyusqo/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.OrJ2y269I0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 23:59:55 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 23:59:55 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 23:59:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ShkImyusqo/Render', 23:59:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:55 INFO - 'HOME': '/Users/cltbld', 23:59:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:55 INFO - 'LOGNAME': 'cltbld', 23:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:55 INFO - 'MOZ_NO_REMOTE': '1', 23:59:55 INFO - 'NO_EM_RESTART': '1', 23:59:55 INFO - 'PAGER': '/bin/cat', 23:59:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:55 INFO - 'PWD': '/builds/slave/test', 23:59:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:55 INFO - 'SHELL': '/bin/bash', 23:59:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OrJ2y269I0/Listeners', 23:59:55 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 23:59:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:55 INFO - 'USER': 'cltbld', 23:59:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:55 INFO - 'XPC_FLAGS': '0x0', 23:59:55 INFO - 'XPC_SERVICE_NAME': '0', 23:59:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:59:55 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-Z6Rqo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:59:55 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)) 23:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:59:55 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-kpvDA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:59:55 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)) 23:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:59:55 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-yKRJoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:59:55 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)) 23:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:59:55 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-usgqYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:59:56 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)) 23:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:59:56 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-twF7oA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:59:56 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)) 23:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:59:56 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-_7V6SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:59:56 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)) 23:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:59:56 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-gQFA5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:59:56 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)) 23:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:59:56 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-CKeZDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:59:56 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)) 23:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:59:56 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-m8_vIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:59:56 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)) 23:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:59:56 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-iAQgHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:59:56 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)) 23:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:59:56 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-cUllve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:59:56 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)) 23:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:59:56 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-Nm0auH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:59:56 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)) 23:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:59:56 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-vmXzoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:59:56 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)) 23:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:59:57 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-Em_BON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:59:57 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)) 23:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:57 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-tGsCuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:57 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)) 23:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:59:57 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-GUTvfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:59:57 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)) 23:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:59:57 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-g83Z21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:59:57 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)) 23:59:57 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)) 23:59:57 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)) 23:59:57 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)) 23:59:57 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)) 23:59:57 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)) 23:59:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:59: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 23:59: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 23:59: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 23:59: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 23:59: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 23:59: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 23:59:59 INFO - Downloading blessings-1.6.tar.gz 23:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:59:59 INFO - Installing collected packages: blessings 23:59:59 INFO - Running setup.py install for blessings 00:00:00 INFO - Successfully installed blessings 00:00:00 INFO - Cleaning up... 00:00:00 INFO - Return code: 0 00:00:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:00:00 INFO - Reading from file tmpfile_stdout 00:00:00 INFO - Current package versions: 00:00:00 INFO - blessings == 1.6 00:00:00 INFO - blobuploader == 1.2.4 00:00:00 INFO - docopt == 0.6.1 00:00:00 INFO - manifestparser == 1.1 00:00:00 INFO - mozInstall == 1.12 00:00:00 INFO - mozcrash == 0.17 00:00:00 INFO - mozdebug == 0.1 00:00:00 INFO - mozdevice == 0.48 00:00:00 INFO - mozfile == 1.2 00:00:00 INFO - mozhttpd == 0.7 00:00:00 INFO - mozinfo == 0.9 00:00:00 INFO - mozleak == 0.1 00:00:00 INFO - mozlog == 3.1 00:00:00 INFO - moznetwork == 0.27 00:00:00 INFO - mozprocess == 0.22 00:00:00 INFO - mozprofile == 0.28 00:00:00 INFO - mozrunner == 6.11 00:00:00 INFO - mozscreenshot == 0.1 00:00:00 INFO - mozsystemmonitor == 0.0 00:00:00 INFO - moztest == 0.7 00:00:00 INFO - mozversion == 1.4 00:00:00 INFO - psutil == 3.1.1 00:00:00 INFO - requests == 1.2.3 00:00:00 INFO - wsgiref == 0.1.2 00:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:00:00 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')]} 00:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:00 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')]} 00:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:00 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 0x10907ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10908b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae0d88060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f1ae00>, '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 0x108d83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f15b20>, '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.ShkImyusqo/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.OrJ2y269I0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 00:00:00 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 00:00:00 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 00:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ShkImyusqo/Render', 00:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:00 INFO - 'HOME': '/Users/cltbld', 00:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:00 INFO - 'LOGNAME': 'cltbld', 00:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:00 INFO - 'MOZ_NO_REMOTE': '1', 00:00:00 INFO - 'NO_EM_RESTART': '1', 00:00:00 INFO - 'PAGER': '/bin/cat', 00:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:00 INFO - 'PWD': '/builds/slave/test', 00:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:00 INFO - 'SHELL': '/bin/bash', 00:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OrJ2y269I0/Listeners', 00:00:00 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 00:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:00 INFO - 'USER': 'cltbld', 00:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:00 INFO - 'XPC_FLAGS': '0x0', 00:00:00 INFO - 'XPC_SERVICE_NAME': '0', 00:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:00 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)) 00:00:00 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)) 00:00:00 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)) 00:00:00 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)) 00:00:00 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)) 00:00:00 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)) 00:00:00 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)) 00:00:00 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)) 00:00:00 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)) 00:00:00 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)) 00:00:00 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)) 00:00:00 INFO - Cleaning up... 00:00:00 INFO - Return code: 0 00:00:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:00:00 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')]} 00:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:00 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')]} 00:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:00 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 0x10907ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10908b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae0d88060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f1ae00>, '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 0x108d83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f15b20>, '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.ShkImyusqo/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.OrJ2y269I0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 00:00:00 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 00:00:00 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 00:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ShkImyusqo/Render', 00:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:00 INFO - 'HOME': '/Users/cltbld', 00:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:00 INFO - 'LOGNAME': 'cltbld', 00:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:00 INFO - 'MOZ_NO_REMOTE': '1', 00:00:00 INFO - 'NO_EM_RESTART': '1', 00:00:00 INFO - 'PAGER': '/bin/cat', 00:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:00 INFO - 'PWD': '/builds/slave/test', 00:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:00 INFO - 'SHELL': '/bin/bash', 00:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OrJ2y269I0/Listeners', 00:00:00 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 00:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:00 INFO - 'USER': 'cltbld', 00:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:00 INFO - 'XPC_FLAGS': '0x0', 00:00:00 INFO - 'XPC_SERVICE_NAME': '0', 00:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:01 INFO - Downloading/unpacking jsonschema 00:00: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 00:00: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 00:00: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 00:00: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 00:00: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 00:00: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 00:00:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:00:03 INFO - Downloading/unpacking functools32 (from jsonschema) 00:00:03 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 00:00:03 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 00:00:03 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 00:00:03 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 00:00:03 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 00:00:03 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 00:00:03 INFO - Downloading functools32-3.2.3-2.tar.gz 00:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:00:04 INFO - warning: no files found matching '*.txt' 00:00:04 INFO - no previously-included directories found matching 'build' 00:00:04 INFO - no previously-included directories found matching 'dist' 00:00:04 INFO - no previously-included directories found matching '.git*' 00:00:04 INFO - Installing collected packages: jsonschema, functools32 00:00:04 INFO - Running setup.py install for functools32 00:00:04 INFO - warning: no files found matching '*.txt' 00:00:04 INFO - no previously-included directories found matching 'build' 00:00:04 INFO - no previously-included directories found matching 'dist' 00:00:04 INFO - no previously-included directories found matching '.git*' 00:00:04 INFO - Successfully installed jsonschema functools32 00:00:04 INFO - Cleaning up... 00:00:04 INFO - Return code: 0 00:00:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:04 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 0x10907ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10908b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae0d88060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f1ae00>, '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 0x108d83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f15b20>, '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.ShkImyusqo/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.OrJ2y269I0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 00:00:04 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 00:00:04 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 00:00:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ShkImyusqo/Render', 00:00:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:04 INFO - 'HOME': '/Users/cltbld', 00:00:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:04 INFO - 'LOGNAME': 'cltbld', 00:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:04 INFO - 'MOZ_NO_REMOTE': '1', 00:00:04 INFO - 'NO_EM_RESTART': '1', 00:00:04 INFO - 'PAGER': '/bin/cat', 00:00:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:04 INFO - 'PWD': '/builds/slave/test', 00:00:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:04 INFO - 'SHELL': '/bin/bash', 00:00:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OrJ2y269I0/Listeners', 00:00:04 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 00:00:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:04 INFO - 'USER': 'cltbld', 00:00:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:04 INFO - 'XPC_FLAGS': '0x0', 00:00:04 INFO - 'XPC_SERVICE_NAME': '0', 00:00:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:04 INFO - Downloading/unpacking flake8 00:00:04 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 00:00:04 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 00:00:04 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 00:00:04 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 00:00:04 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 00:00:04 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 00:00:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:00:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:00:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 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 00:00:07 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 00:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:00:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:00:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:00:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:00:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:00:08 INFO - no previously-included directories found matching 'docs/_build' 00:00:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:00:08 INFO - Running setup.py install for pep8 00:00:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:00:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:00:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:00:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:00:08 INFO - no previously-included directories found matching 'docs/_build' 00:00:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:00:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:00:08 INFO - Cleaning up... 00:00:08 INFO - Return code: 0 00:00:08 INFO - Running post-action listener: _resource_record_post_action 00:00:08 INFO - Running post-action listener: _start_resource_monitoring 00:00:08 INFO - Starting resource monitoring. 00:00:08 INFO - ##### 00:00:08 INFO - ##### Running install step. 00:00:08 INFO - ##### 00:00:08 INFO - Running pre-action listener: _resource_record_pre_action 00:00:08 INFO - Running main action method: install 00:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:00:09 INFO - Reading from file tmpfile_stdout 00:00:09 INFO - Detecting whether we're running mozinstall >=1.0... 00:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:00:09 INFO - Reading from file tmpfile_stdout 00:00:09 INFO - Output received: 00:00:09 INFO - Usage: mozinstall [options] installer 00:00:09 INFO - Options: 00:00:09 INFO - -h, --help show this help message and exit 00:00:09 INFO - -d DEST, --destination=DEST 00:00:09 INFO - Directory to install application into. [default: 00:00:09 INFO - "/builds/slave/test"] 00:00:09 INFO - --app=APP Application being installed. [default: firefox] 00:00:09 INFO - mkdir: /builds/slave/test/build/application 00:00:09 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'] 00:00:09 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 00:00:30 INFO - Reading from file tmpfile_stdout 00:00:30 INFO - Output received: 00:00:30 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 00:00:30 INFO - Running post-action listener: _resource_record_post_action 00:00:30 INFO - ##### 00:00:30 INFO - ##### Running run-tests step. 00:00:30 INFO - ##### 00:00:30 INFO - Running pre-action listener: _resource_record_pre_action 00:00:30 INFO - Running main action method: run_tests 00:00:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:00:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:00:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:00:30 INFO - 2016-07-18 00:00:30.963 screenresolution[6318:108744] starting screenresolution argv=screenresolution get 00:00:30 INFO - 2016-07-18 00:00:30.965 screenresolution[6318:108744] Display 0: 1600x1200x32@60 00:00:30 INFO - 2016-07-18 00:00:30.970 screenresolution[6319:108746] starting screenresolution argv=screenresolution list 00:00:30 INFO - Available Modes on Display 0 00:00:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:00:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:00:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:00:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:00:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:00:31 INFO - Intel Iris: 00:00:31 INFO - Chipset Model: Intel Iris 00:00:31 INFO - Type: GPU 00:00:31 INFO - Bus: Built-In 00:00:31 INFO - VRAM (Dynamic, Max): 1536 MB 00:00:31 INFO - Vendor: Intel (0x8086) 00:00:31 INFO - Device ID: 0x0a2e 00:00:31 INFO - Revision ID: 0x0009 00:00:31 INFO - Displays: 00:00:31 INFO - Display: 00:00:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:00:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:00:31 INFO - Display Serial Number: 1600x1200 60 00:00:31 INFO - Main Display: Yes 00:00:31 INFO - Mirror: Off 00:00:31 INFO - Online: Yes 00:00:31 INFO - Rotation: Supported 00:00:31 INFO - Return code: 0 00:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:00:31 INFO - Python 2.7.3 00:00:31 INFO - Return code: 0 00:00:31 INFO - grabbing minidump binary from tooltool 00:00: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')]} 00:00:31 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 0x108f1ae00>, '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 0x108d83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f15b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:00:31 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 00:00:31 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 00:00:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:00:31 INFO - Return code: 0 00:00:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:00:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:00:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:00:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:00:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:00:32 INFO - Return code: 0 00:00:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0280', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0280 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:00:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ShkImyusqo/Render', 00:00:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:32 INFO - 'HOME': '/Users/cltbld', 00:00:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:32 INFO - 'LOGNAME': 'cltbld', 00:00:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:00:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:32 INFO - 'MOZ_NO_REMOTE': '1', 00:00:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:00:32 INFO - 'NO_EM_RESTART': '1', 00:00:32 INFO - 'PAGER': '/bin/cat', 00:00:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:32 INFO - 'PWD': '/builds/slave/test', 00:00:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:00:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:32 INFO - 'SHELL': '/bin/bash', 00:00:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OrJ2y269I0/Listeners', 00:00:32 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 00:00:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:32 INFO - 'USER': 'cltbld', 00:00:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:32 INFO - 'XPC_FLAGS': '0x0', 00:00:32 INFO - 'XPC_SERVICE_NAME': '0', 00:00:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0280', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:00:32 INFO - mozversion application_buildid: 20160716031557 00:00:32 INFO - mozversion application_changeset: 24af5e8917a2a3efabc8f1c614c709282fc2d473 00:00:32 INFO - mozversion application_display_name: Firefox 00:00:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:00:32 INFO - mozversion application_name: Firefox 00:00:32 INFO - mozversion application_remotingname: firefox 00:00:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:00:32 INFO - mozversion application_vendor: Mozilla 00:00:32 INFO - mozversion application_version: 48.0 00:00:32 INFO - mozversion platform_buildid: 20160716031557 00:00:32 INFO - mozversion platform_changeset: 24af5e8917a2a3efabc8f1c614c709282fc2d473 00:00:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:00:32 INFO - mozversion platform_version: 48.0 00:00:32 INFO - using testdate: 1468825232 00:00:32 INFO - actual date: 1468825232 00:00:32 INFO - starting webserver on 'localhost:56990' 00:00:32 INFO - SUITE-START | Running 2 tests 00:00:32 INFO - TEST-START | dromaeo_css 00:00:32 INFO - operating with platform_type : mac_ 00:00:32 INFO - Initialising browser for dromaeo_css test... 00:00:32 INFO - TEST-INFO | started process 6337 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/tmp9mSKxD/profile http://localhost:56990/getInfo.html) 00:00:35 INFO - PROCESS | 6337 | __metrics Screen width/height:1600/1200 00:00:35 INFO - PROCESS | 6337 | colorDepth:24 00:00:35 INFO - PROCESS | 6337 | Browser inner width/height: 1024/689 00:00:35 INFO - PROCESS | 6337 | __metrics 00:00:35 INFO - PROCESS | 6337 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:00:35 ERROR - PROCESS | 6337 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:00:35 INFO - TEST-INFO | 6337: exit 0 00:00:35 INFO - Browser initialized. 00:00:35 INFO - Running cycle 1/1 for dromaeo_css test... 00:00:35 INFO - TEST-INFO | started process 6341 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/tmp9mSKxD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:00:47 INFO - PROCESS | 6341 | RSS: Main: 160415744 00:00:47 INFO - PROCESS | 6341 | 00:01:38 INFO - PROCESS | 6341 | 1468825298922 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] 00:03:48 INFO - PROCESS | 6341 | Cycle 1(1): loaded http://localhost:56990/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56990/tests/dromaeo/cssquery-ext.html) 00:03:50 INFO - PROCESS | 6341 | RSS: Main: 299814912 00:03:50 INFO - PROCESS | 6341 | 00:06:53 INFO - PROCESS | 6341 | Cycle 1(1): loaded http://localhost:56990/tests/dromaeo/cssquery-ext.html (next: http://localhost:56990/tests/dromaeo/cssquery-jquery.html) 00:06:53 INFO - PROCESS | 6341 | RSS: Main: 302735360 00:06:53 INFO - PROCESS | 6341 | 00:09:55 INFO - PROCESS | 6341 | Cycle 1(1): loaded http://localhost:56990/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56990/tests/dromaeo/cssquery-mootools.html) 00:09:56 INFO - PROCESS | 6341 | RSS: Main: 310575104 00:09:56 INFO - PROCESS | 6341 | 00:12:58 INFO - PROCESS | 6341 | Cycle 1(1): loaded http://localhost:56990/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56990/tests/dromaeo/cssquery-prototype.html) 00:12:58 INFO - PROCESS | 6341 | RSS: Main: 303869952 00:12:58 INFO - PROCESS | 6341 | 00:16:01 INFO - PROCESS | 6341 | Cycle 1(1): loaded http://localhost:56990/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56990/tests/dromaeo/cssquery-yui.html) 00:16:02 INFO - PROCESS | 6341 | RSS: Main: 270798848 00:16:02 INFO - PROCESS | 6341 | 00:19:05 INFO - PROCESS | 6341 | Cycle 1(1): loaded http://localhost:56990/tests/dromaeo/cssquery-yui.html (next: http://localhost:56990/tests/dromaeo/cssquery-dojo.html) 00:19:05 INFO - PROCESS | 6341 | RSS: Main: 310054912 00:19:05 INFO - PROCESS | 6341 | 00:19:05 INFO - PROCESS | 6341 | __start_tp_report 00:19:05 INFO - PROCESS | 6341 | _x_x_mozilla_page_load 00:19:05 INFO - PROCESS | 6341 | _x_x_mozilla_page_load_details 00:19:05 INFO - PROCESS | 6341 | |i|pagename|runs| 00:19:05 INFO - PROCESS | 6341 | |0;dojo.html;3286.9835650821747;3529.717622590192;3564.260021065601;3570.9464358034634;3645.562532496101;5914.260717410324;5954.196183515224;5959.731812068457;5965.164876917235;5986.311574168977;5965.850853728659;5992.580519363646;5998.100284957248;5998.220231369926;6026.608270462428;5301.787928482875;5327.653702509344;5420.647657902224;5452.754626041818;5500.28496295483;5402.486763757456;5437.102878025121;5437.483439073281;5443;5444.020076386249;5384.219288203209;5426.158945363475;5431.511163995239;5446.91829622556;5461.0716178249795;5448.128299472105;5476.780928762844;5480.342358916916;5496.31296087989;5517.503424691757;5283.365996080456;5313.867153321159;5379.273798037254;5391.595630327741;5395.460453954613;5729.8567535811935;5730.570207234432;5760.3951585083805;5793.333766616851;5871.79448719297;6279.780207692755;6293.056041593752;6300.59046161998;6301.558890877641;6304.432601065881;6213.627182369072;6326.08271800591;6358.586691865014;6360.52296077796;6377.394147555975;5979.940200597982;6049.885719964208;6068.274312698971;6103.572749907553;6117.785877494311;6496.70764815575;6508;6515.087887695727;6532.706028228741;6538.574992625464;6167.259928808482;6262;6274.498040156868;6288.056791481223;6302.149209856702;6233.812985610439;6297.779577714849;6326.6520341381665;6405.583637063576;6431.13179720741;5478.616496845262;6120.969395152996;6258.812235632848;6275.937240627627;6281.246250449975;6178.208319587359;6251.937480625135;6261.24865016201;6269.8746025079245;6303.873922521524;4963.156263435225;5024.145895197752;5027.673201241908;5081.212412076134;5117.130087885069;4572;4584.9541504585195;4595.2188128018315;4600.608948239437;4625.352450656911;6086.2696476422225;6098.1157732128595;6105.633661980207;6126.9387306127255;6155.784547540815;5142.6400151989;5520.282363292747;6206.441420272197;6288.276848162428;6321.367863213642;6082.270127584629;6107.931112055373;6110.792407652138;6119.380693981147;6123.418275263843;5560.582956278296;5595.468430499096;5601.859953501195;5610.719464026783;5616.213730077792;6452.22573291208;6522.380373864476;6626.966865165643;6649.301823308483;6656.467482601477;6367.076773867856;6392.776252831129;6394.872102558016;6404.583702059351;6419.839504012437;6555.541112122296;6614.305497922841;6619.933800662125;6624.867502650017;6629.834254143685;6183.288921774054;6244.2819075806865;6306.369363063657;6313.65274909866;6323.905141422974;6346.714397852015;6356.046593011085;6361.2048493938255;6364.427201551883;6370.840728981627;6154.230721159855;6172.9074063889975;6240.12638230639;6252.187215661935;6283.842903927439;6160.753569857335;6201.348858369806;6244.5316601256;6259.186305780219;6266.624002559861;6130;6137.877242455215;6141.815745527641;6160.7535698571555;6214.782482613087;6123.282621474203;6148.938510615016;6204.968975155095;6235.251769787655;6249.96875015622;6157.014877619559;6203.596766210182;6223.968880155751;6234.594751341148;6244.65654389013 00:19:05 INFO - PROCESS | 6341 | |1;ext.html;540.3084052412913;541.5045233611245;570.2387312937228;575.1975993489085;617.0035392840562;32326.19184520388;32961.67038329616;40147.19705605886;40773.796131019306;40891.18217635646;44057;44412.55587444125;44522.777386113106;44608.10783784322;44612.776936115355;9679.080487353707;9882;9890.357126786736;9892.406455612687;9895.158911492532;9259.675911343104;9450.574724137396;9452.716418507422;9461.479618620973;11901.523939042429;11882.524699012029;11958.701032474215;11960.222585531956;11961.641150765447;11975.221610595283;9821.558029888636;11882.10884183681;11957.820632690517;11959.641210763692;11972.221805582609;11768.588099416565;11869.762604747943;11888.881111188864;11897.464614092387;11914.582989595408;40448.79775601133;40950.795246023874;41051.7947410264;43241.56758432407;43301.91745206364;2841.687414384416;3291;3467.7052450541732;3726.850925962958;3830.865919692825;29169.416611667646;29647.55528667072;30431.847840760875;31192.37615247705;31388.901388451293;2739.5479745842113;2746.32714984828;2755.200991712401;2797.1888152435768;2848.6011958325853;510453;510890;512609;512737.9999999963;513096;37370.81314593464;38336;68631.31368686349;69097.65451172712;69128;37142;37391;37482.625173748456;37529.43705844414;37537.06157346088;13692;16549.751753723704;16552.00687958702;16562;16568.420105296256;14428.495002674856;14498.492552760603;14516.85483145155;14535.345909434101;14539.491117810825;8077.474964127313;8248.422610417214;8535.95732021336;8641.611127499278;8703.564821758886;3458.844352004166;3551.076720052805;3555.093451169987;3561.732870034758;3613.9638603614153;887.5029983209423;1017.2624846985876;1065.4619417194267;1068.0974576482859;1123.07346439188;28818.392266346236;29716.55425168624;29931.40137197244;30362;30368.93708720184;831.8918540589684;1091.7980173667897;1111.1166622535104;1170.584442522892;1228.3305598448867;11043.779124417628;16552.75170872438;17146.314147434212;17166.485005449857;17227.3970411035;635045;642430;643749;646141;647819;66855.66572167107;67368.66315668488;67603.32396676068;67710.66144669344;67761.32238677649;1264.9683757906125;1445.6747231872955;1482.5626440200167;1594.2985086561876;1612.0569466862016;24418.75581244236;28982.13053608395;30069.849650751607;30790;30903.69096309008;52464.21303680524;53359;53377.4662253388;53445.46554534561;53496;425492;432410;432737;432780;433201;44030.779846100566;44503.332450012625;46523.53476465192;46665.76667116643;48434.27348589845;47650.80688381987;47817.76091119522;47825.76087119542;48521.27218091661;48747.75626121847;39147.2170556593;39685.801570991964;39836;40007.59992400155;40306.1938761229;32831.50752738663;38911.80544097262;39192;39266.214675705756;39453.40819887647;39233;39406;39735.80132099437;39991;40049;30349.48252587406;33083.669163308055;34350.312993739484;35613;37145.442818358286;25757;26009;26066.60900086538;26507.204783856516;26598.93604255808 00:19:05 INFO - PROCESS | 6341 | |2;jquery.html;417.89761508430433;418.1845401467139;418.27638185938343;420.74124413485714;427.9721818081824;17526.561835954108;20369.592608147846;21019.684704729403;21039.894800525995;22370.66444003337;12283.508659653604;12581.119321647466;14461.855381446183;21336.679949800764;21368.931553422346;5095.133827249358;5364.7317634118335;5536.892621475721;5617.719114044302;5648.01159797036;5020.995800839828;6161.568690191689;6199.876002479948;6237.781677641284;6240.906386404207;5600.859978500529;5600.971995140039;6198.070289456595;6216.37836216377;6216.378362163793;5541.778328866861;5575.470330318613;5593.468620481048;5608.383077861432;5608.691521966311;5211.42674305826;5449.291592093003;5455.427180146067;5468.48049435303;5510.173473978895;14282.785758213635;14302.213378264192;21066.94665266746;26614.33464163392;26966.92132314705;2062.669972804359;2172.880491572963;2258.8691796008916;2337.100216416675;2840.957385639217;10080;10496.265261431703;10767.946160269226;13076.019298552646;14907.850921490755;1807.7107662774024;1824.0606087864628;1849.6208277303122;1851.139220262571;1902.077492416177;121516.39241803734;124323.37838310932;127291;127410;130750;11758.706032349088;11911.166218364631;11916.523339066514;11960.58137965167;12030.4586293617;15802.288896999662;15850;15868.761968570481;15887.046777193405;15888.443904463289;8146.470479418819;9280.02559731232;9318.347715659838;9406.858897116548;9418.717438476857;9411.90588094124;9444.95277523608;9461;9461.858072128924;9559;4799.5601319604675;4803.95196048042;4822.71063736177;4840.588549973291;4856.587190088811;2008.3590079046007;2064.7081739269397;2097.863638863469;2103.7475502939437;2115.3865379039908;1001.3040936549029;1040.2627611888165;1044.2637940252105;1051.358671210561;1120.9159313051555;21143.471413214484;21551.56896862054;21656.56686866254;21867.453313667287;21947.451313717283;994.5971881387904;1018.1244130048152;1021.0963297481782;1066.9199810014125;1089.7330154112294;10749;11685.824712629317;11687;11720.120990925714;11721.706957325965;408061;484633;488902;500675;654825;80100.59949700214;126412.36793815972;129914.35042824726;142592.28703856413;144542.27728861498;1052.489542571852;1065.1053115383115;1090.9945450272858;1098.6813823990954;1102.4653043274006;14956.476523321631;18503.907480462512;18853.811461885205;18937.863728176355;19156;55216.723916380164;55593.88812223814;55846.44153558413;56493.8701225965;57389.85220295487;84135;86181;87364;87418.88067835191;88843;7990.440669153103;8080.151584083586;8192.713255036046;8222.876656850272;8480.703175388831;7296.015037969806;7543.660535275816;10158.831734350644;11314.773704525698;12631.557895473614;11151.498182581965;11236.325820450798;11355;11506.712332191762;11619.302841829518;11061.446927653424;11078.058365039062;11095.22333436684;11260.493277802683;11341.943290283496;11214.551847449162;11579.88420115788;11583.6524904253;11904;11950.581729639422;8305.086440491421;8540.572971351532;8576.44253123545;8606.956965215133;8779.385443019182;10459.47702614851;10610.734731631772;11509.366984815915;11647.59233426826;11660.591879284184 00:19:05 INFO - PROCESS | 6341 | |3;mootools.html;1530.043722673329;1635.0516700313817;1667.866570674346;1977.6835706286997;2067.66917293233;8418.494890306578;8982.86525702115;9139.360244782867;9142.222911052551;9148.862767058492;7288.635568221581;9263.397879137869;9265.444073355604;9283.210927071206;9306.162445379914;2566.640670306154;2593.455374371384;2594.2995391244353;2594.624848830123;2599.155274535774;2517.8237523373373;2578.40696639773;2583.173384516946;2586.6249393837884;2587.935301617456;2531.848089114659;2567.845929244242;2568.4092658688514;2579.767820896119;2581.2514370832437;2535.581629031217;2574.4078861861785;2575.8840852161698;2579.948401031969;2580.58710606303;2523.4574566468295;2563.8974441022337;2572.884220210095;2573.137998770414;2578.6776652918384;9030.367874248805;9353.812923741487;9432.811343773155;9436.245100391952;9438.244940404751;5798.985177593946;5947.1971283876555;5972.193753843219;6008.218931538872;6025.668588227646;3624.966884437949;3710.2950439416422;3744.981275093607;3746.4942232798494;3769.792661403622;1029.1321251927727;1036.2797855490437;1043.8695163104612;1059.6132411669762;1077.849101125843;12365.07261955357;12479.75040499185;12552.81170782439;12563.309018004005;12568.74862502754;4086.5300490443383;4753.718215256627;4861.222204447272;4929.654924155347;4962.280469331999;8315.750527484186;9903.900960990299;9913.851292230622;9924;9938.552765125587;5636.013697602903;5702.971485142548;5711.8857622848145;5713.228714123623;5716.685582292931;4717.198076327033;4742.9762851186215;4803.78382972767;4856.077345304381;5291.894162116736;3308.718758905472;3508.614052454228;3996.0009997500624;4128.4632997710105;4149.688773341951;1245.2404033539533;1267.66406902171;1267.8985681145487;1276.8723127687342;1279.649969282416;951.7810903492235;988.9270141895979;989.2333441582687;990.2968892086699;1018.4195008844887;6004.459598636144;6154.046122850876;6172.537059720539;6205.441510264008;6219.751209951642;449.1354143274184;463.40221114762255;463.4253525628197;486.43087587522683;487.663512176597;3996.8800935971967;4011.3180759270995;4072.959270407258;4100.159467309194;4169.207850508394;11267.38029408374;11627.53489860413;11705.473253703603;11838.526458941718;11854.466549005316;10438.321509101885;11622.70943226426;11624.476898539586;11652.242604230698;11684.240524365889;7229.963850180716;7997.6800927963395;8972.910270897339;8982.820343593223;9032.909670903338;5938.257717785277;5965.940340596712;5983.611065280743;6079.726412311368;6107.633541987495;10151.543180556744;10404.271700980858;10459.477026148814;10462.94768526183;10468.895311046792;10147.847782283125;10699.304545204848;10845.186611004048;10870.239083264096;10870.510827012646;7350.595717235603;7409.518381305198;7615.6953721850505;7991.960040199761;7992.560409177318;7450.664720087718;8635.352348574008;8736.475811451333;8787.297016238814;8806.383553151474;7685.807854803675;7798.844023119393;7810.609469526615;7851.725189618564;7920.801979950317;7545.886811697938;7586.203448637813;7659.578723170279;7730.652120654471;7739.535627862347;7427.071616047994;7486.326230639269;7489.66296516669;7502.699892004259;7507.812304692208;4969.105560999054;4989.775460104232;5087.898242035065;5155.561777248976;5179.067767801681;5084.720340381315;5129.897402052013;5196.454372291007;5197;5224.451432599522 00:19:05 INFO - PROCESS | 6341 | |4;prototype.html;331.9668033196681;336.81306874684554;340.0766917818124;346.24518549561947;346.2952890867086;5749.281339832521;5908.852278693035;6587.7035533400995;6599.208095028597;6636.50226233032;6541.215054193492;6569.883119869622;6570.277269500351;6603.042558828979;6618.702158402872;4688.507706690791;4872.147374209517;4884.194107972198;4898.167311557044;4901.509849015106;4821.831235906744;4905.8773530661665;4930.654854160192;4954.925676114861;4956.1822299320565;4837.153498137829;4881.682690625098;4890.584300334458;4894.167991441445;4898.216285394337;4696.084263568606;4894.535019173209;4895.608351331903;4901.779419926112;4917.2869933859565;4125.50493940729;4231.555686652919;4239.0885959518855;4252.829886804555;4255.340422234528;6266.652669675996;6325.652089135096;6341;6343.936560634381;6380.776672816429;4720.433547974265;5807.344906701612;5817.447342502455;5818.0400233961345;5827.592068555203;7006.579605223703;7008.159020917472;7018.192907815615;7021.332973367522;7028.648567571601;4354.54277300882;4538.183127037132;4702.788374523155;4713.976430117862;4715.104130215248;7269.345758881726;7348.742794002184;7376.0411146550605;7401.888971665429;7433.293837085523;4645.814167433265;4646;4648.790804413809;4659.1147681941;4659.254519276899;4724.669273150916;4744.857654270378;4751.6436267279405;4762.738049407247;4763.833265835679;5617.241672374259;5617.578681598815;5627.184058311522;5630.127330263816;5631.352394474688;6727.663616819237;7035.155781306276;7041.788746337618;7050.612216328049;7055.9294407056295;1623.7077326081182;1634.730269505542;1646.5801220688647;1647.8022637283364;1650.290375138678;1026.1893104447404;1028.3675539543126;1047.9685609431729;1048.8951104889602;1050.5482642463662;5671.234383358276;6516.283208847023;6534.836629084216;6658.766943156967;6721.395074443323;7160.212376638566;7290.489665723455;7329.963350183321;7331.230220826843;7381.66782494789;6705.329467053353;6763.458923286125;6769.593824370455;6771.72913083481;6783.796486105425;3862.439946207784;3890.124721937598;3898.7465814721954;3911.2764138634443;3912.5304963404005;7517.849643007218;7795.961020194863;7811.882821757678;7815.101263354673;7819.804504887309;7527.360174385239;7579.962100189464;7584.051993500812;7592;7604.315611594983;7715.1899050600005;7772.57250851186;7783.961080194563;7789.493682910706;7802.765917022499;7020.824479387852;7332.706691732271;7341.522801017917;7362.3741981932135;7385.261473852572;5859.824205273849;7200.639968001684;7213.3868621167785;7223.638818058971;7232.963835181001;7647.158812530728;7694.384449244159;7701.460897737329;7706.653200605874;7725.072991241087;4176.749395036308;4675.953240467552;4678.041001594597;4705.682408925506;4720.4807471177455;7336.853262934818;7341.4126869849215;7342.853142937218;7355.374793142642;7358.300961408658;6780.220274668279;7079.539829911039;7130.8217294565975;7133.3936615388275;7135.571865687868;7028.262032486719;7082.114735658043;7092.574445533284;7103.360697537247;7113.430925526049;5980.910286345796;6646.268910419753;6897.862042759217;6913.51605387618;6935.306469353024;5907.586468947305;6767.966160169168;7015.964920175366;7105.005299258211;7119.288071192839;6669.599824010575;6886.69009894566;6942.895856562257;6970.79087627372;6980.7905762827195 00:19:05 INFO - PROCESS | 6341 | |5;yui.html;770.9383249340053;775.495927647029;778.1906816910414;793.5516433215234;818.9590520473977;15127.319270632821;15327.157006364645;15444.459443919464;15462.922685386586;15463.845361546395;14212.076215046041;14428;14458.132512049284;14462.710745785078;14519.20144392058;779.8479296537178;799.476342995339;928.4290161550631;960.135877710063;961.4135377419768;787.4684587903171;969.5103972493881;972.3776782858976;973.1339108193713;973.5570315506427;1013.0882206014572;1022.2384323678832;1022.5091955861154;1023.3706270643574;1024.3137098144261;811.059171361221;990.0891180114312;1008.6167256442578;1014.9746256343576;1019.9694009179736;765.7243392378739;766.789132988427;768.1780494870435;769.0156599552581;769.8421823526164;15349.309281082267;15416.845831541654;15444.845551544566;15445.691086178325;15468.30392632323;12757.808632870514;12819.743605127938;13043.86956130436;13099.607011789662;13163;10240.590376384936;10251.89748102517;10285.434301113435;10365;10728.624498142528;3566.144125409909;3577.2130131371055;3624.4925710400566;3665.21197942441;3817.6945844332386;79648.60175699084;81430.77853832138;81760;81955;82060;8886.066962968924;8969.50667713269;9092.81814363709;9166.954165229132;9336.299777516713;19126.904365478083;19131.23475060982;19156.137973791214;19159.233630654617;19186.424407267805;7299.41604671625;7448.366888814403;7561.508501947355;7587.772366829004;7691.5769632670745;4154.065335299533;4175.519815221289;4260;4314.870553883388;4432.778361081998;3720.3861362874823;3761.3793724035777;3783.243351329745;3784.4890939723336;3797.6771974382486;670.6345041952147;679.2765704524666;693.8716337477583;704.0530486495655;725.4957804325943;584.0334246821517;591.4617697894895;606.7876243314804;641.5060403489288;652.1228947066188;7832.530048197126;8209.753707388787;8302.460340077876;8368;8459.873101903477;507.59138893191334;582.2954225387329;605.9545534084962;620.8789286089169;624.7563450254404;3403.540522029544;3482.2861313431195;3901.96098039016;3966.960330396717;3991.4811074560703;95470.0452995475;97070;97793.02413198276;98791;99022.50488747511;76034;76615.46769064698;77049.2295077042;77207.84188237181;81756.77364839532;67862.98205526921;70716.64641676759;71806;71827.64086179536;72898.6355068232;8585.313174946114;8696.565171741515;8738.300935925237;8766.386352955487;8965.135031230206;48637;48927.75536122297;50366.134667579594;50649.74675126601;51595.742021289654;51806;66366;67441.65116697736;67690.3230967684;67811;11068.391238481961;11190.552377905118;11203.21577489568;11468.483918223867;11700.425906300601;11753.882461175279;11827.704307392383;12000.75998480043;12055.035597152382;12678;11593.710157246136;11622.128340374336;11638.243514171552;11868.169228153947;11896.167268291136;11534.1926065178;11611.5355385787;11726.120540959291;11752.941235293769;11814.232074915102;11390.772184556097;11507.136964727511;11545.88454115448;11669.708257293636;12263;9432.151106400457;9462.858057129011;9790.559424826042;9869.259805514472;9896.406215627085;8468.280196183394;9847.409155450696;10033.943041676584;10122.089011988955;10145.797084058426 00:19:05 INFO - PROCESS | 6341 | __end_tp_report 00:19:05 INFO - PROCESS | 6341 | __start_cc_report 00:19:05 INFO - PROCESS | 6341 | _x_x_mozilla_cycle_collect,1258 00:19:05 INFO - PROCESS | 6341 | __end_cc_report 00:19:05 INFO - PROCESS | 6341 | __startTimestamp1468826345315__endTimestamp 00:19:05 INFO - PROCESS | 6341 | 00:19:05 INFO - PROCESS | 6341 | ------- Summary: start ------- 00:19:05 INFO - PROCESS | 6341 | Number of tests: 6 00:19:05 INFO - PROCESS | 6341 | 00:19:05 INFO - PROCESS | 6341 | [#0] dojo.html Cycles:165 Average:5911.28 Median:6148.94 stddev:632.20 (10.3%) stddev-sans-first:599.68 00:19:05 INFO - PROCESS | 6341 | Values: 3287.0 3529.7 3564.3 3570.9 3645.6 5914.3 5954.2 5959.7 5965.2 5986.3 5965.9 5992.6 5998.1 5998.2 6026.6 5301.8 5327.7 5420.6 5452.8 5500.3 5402.5 5437.1 5437.5 5443.0 5444.0 5384.2 5426.2 5431.5 5446.9 5461.1 5448.1 5476.8 5480.3 5496.3 5517.5 5283.4 5313.9 5379.3 5391.6 5395.5 5729.9 5730.6 5760.4 5793.3 5871.8 6279.8 6293.1 6300.6 6301.6 6304.4 6213.6 6326.1 6358.6 6360.5 6377.4 5979.9 6049.9 6068.3 6103.6 6117.8 6496.7 6508.0 6515.1 6532.7 6538.6 6167.3 6262.0 6274.5 6288.1 6302.1 6233.8 6297.8 6326.7 6405.6 6431.1 5478.6 6121.0 6258.8 6275.9 6281.2 6178.2 6251.9 6261.2 6269.9 6303.9 4963.2 5024.1 5027.7 5081.2 5117.1 4572.0 4585.0 4595.2 4600.6 4625.4 6086.3 6098.1 6105.6 6126.9 6155.8 5142.6 5520.3 6206.4 6288.3 6321.4 6082.3 6107.9 6110.8 6119.4 6123.4 5560.6 5595.5 5601.9 5610.7 5616.2 6452.2 6522.4 6627.0 6649.3 6656.5 6367.1 6392.8 6394.9 6404.6 6419.8 6555.5 6614.3 6619.9 6624.9 6629.8 6183.3 6244.3 6306.4 6313.7 6323.9 6346.7 6356.0 6361.2 6364.4 6370.8 6154.2 6172.9 6240.1 6252.2 6283.8 6160.8 6201.3 6244.5 6259.2 6266.6 6130.0 6137.9 6141.8 6160.8 6214.8 6123.3 6148.9 6205.0 6235.3 6250.0 6157.0 6203.6 6224.0 6234.6 6244.7 00:19:05 INFO - PROCESS | 6341 | 00:19:05 INFO - PROCESS | 6341 | [#1] ext.html Cycles:180 Average:66929.33 Median:20683.96 stddev:143066.46 (691.7%) stddev-sans-first:143380.96 00:19:05 INFO - PROCESS | 6341 | Values: 540.3 541.5 570.2 575.2 617.0 32326.2 32961.7 40147.2 40773.8 40891.2 44057.0 44412.6 44522.8 44608.1 44612.8 9679.1 9882.0 9890.4 9892.4 9895.2 9259.7 9450.6 9452.7 9461.5 11901.5 11882.5 11958.7 11960.2 11961.6 11975.2 9821.6 11882.1 11957.8 11959.6 11972.2 11768.6 11869.8 11888.9 11897.5 11914.6 40448.8 40950.8 41051.8 43241.6 43301.9 2841.7 3291.0 3467.7 3726.9 3830.9 29169.4 29647.6 30431.8 31192.4 31388.9 2739.5 2746.3 2755.2 2797.2 2848.6 510453.0 510890.0 512609.0 512738.0 513096.0 37370.8 38336.0 68631.3 69097.7 69128.0 37142.0 37391.0 37482.6 37529.4 37537.1 13692.0 16549.8 16552.0 16562.0 16568.4 14428.5 14498.5 14516.9 14535.3 14539.5 8077.5 8248.4 8536.0 8641.6 8703.6 3458.8 3551.1 3555.1 3561.7 3614.0 887.5 1017.3 1065.5 1068.1 1123.1 28818.4 29716.6 29931.4 30362.0 30368.9 831.9 1091.8 1111.1 1170.6 1228.3 11043.8 16552.8 17146.3 17166.5 17227.4 635045.0 642430.0 643749.0 646141.0 647819.0 66855.7 67368.7 67603.3 67710.7 67761.3 1265.0 1445.7 1482.6 1594.3 1612.1 24418.8 28982.1 30069.8 30790.0 30903.7 52464.2 53359.0 53377.5 53445.5 53496.0 425492.0 432410.0 432737.0 432780.0 433201.0 44030.8 44503.3 46523.5 46665.8 48434.3 47650.8 47817.8 47825.8 48521.3 48747.8 39147.2 39685.8 39836.0 40007.6 40306.2 32831.5 38911.8 39192.0 39266.2 39453.4 39233.0 39406.0 39735.8 39991.0 40049.0 30349.5 33083.7 34350.3 35613.0 37145.4 25757.0 26009.0 26066.6 26507.2 26598.9 00:19:05 INFO - PROCESS | 6341 | 00:19:05 INFO - PROCESS | 6341 | [#2] jquery.html Cycles:180 Average:32867.67 Median:21105.21 stddev:87098.37 (412.7%) stddev-sans-first:87308.63 00:19:05 INFO - PROCESS | 6341 | Values: 417.9 418.2 418.3 420.7 428.0 17526.6 20369.6 21019.7 21039.9 22370.7 12283.5 12581.1 14461.9 21336.7 21368.9 5095.1 5364.7 5536.9 5617.7 5648.0 5021.0 6161.6 6199.9 6237.8 6240.9 5600.9 5601.0 6198.1 6216.4 6216.4 5541.8 5575.5 5593.5 5608.4 5608.7 5211.4 5449.3 5455.4 5468.5 5510.2 14282.8 14302.2 21066.9 26614.3 26966.9 2062.7 2172.9 2258.9 2337.1 2841.0 10080.0 10496.3 10767.9 13076.0 14907.9 1807.7 1824.1 1849.6 1851.1 1902.1 121516.4 124323.4 127291.0 127410.0 130750.0 11758.7 11911.2 11916.5 11960.6 12030.5 15802.3 15850.0 15868.8 15887.0 15888.4 8146.5 9280.0 9318.3 9406.9 9418.7 9411.9 9445.0 9461.0 9461.9 9559.0 4799.6 4804.0 4822.7 4840.6 4856.6 2008.4 2064.7 2097.9 2103.7 2115.4 1001.3 1040.3 1044.3 1051.4 1120.9 21143.5 21551.6 21656.6 21867.5 21947.5 994.6 1018.1 1021.1 1066.9 1089.7 10749.0 11685.8 11687.0 11720.1 11721.7 408061.0 484633.0 488902.0 500675.0 654825.0 80100.6 126412.4 129914.4 142592.3 144542.3 1052.5 1065.1 1091.0 1098.7 1102.5 14956.5 18503.9 18853.8 18937.9 19156.0 55216.7 55593.9 55846.4 56493.9 57389.9 84135.0 86181.0 87364.0 87418.9 88843.0 7990.4 8080.2 8192.7 8222.9 8480.7 7296.0 7543.7 10158.8 11314.8 12631.6 11151.5 11236.3 11355.0 11506.7 11619.3 11061.4 11078.1 11095.2 11260.5 11341.9 11214.6 11579.9 11583.7 11904.0 11950.6 8305.1 8540.6 8576.4 8607.0 8779.4 10459.5 10610.7 11509.4 11647.6 11660.6 00:19:05 INFO - PROCESS | 6341 | 00:19:05 INFO - PROCESS | 6341 | [#3] mootools.html Cycles:180 Average:5962.50 Median:2673.83 stddev:3381.29 (126.5%) stddev-sans-first:3374.37 00:19:05 INFO - PROCESS | 6341 | Values: 1530.0 1635.1 1667.9 1977.7 2067.7 8418.5 8982.9 9139.4 9142.2 9148.9 7288.6 9263.4 9265.4 9283.2 9306.2 2566.6 2593.5 2594.3 2594.6 2599.2 2517.8 2578.4 2583.2 2586.6 2587.9 2531.8 2567.8 2568.4 2579.8 2581.3 2535.6 2574.4 2575.9 2579.9 2580.6 2523.5 2563.9 2572.9 2573.1 2578.7 9030.4 9353.8 9432.8 9436.2 9438.2 5799.0 5947.2 5972.2 6008.2 6025.7 3625.0 3710.3 3745.0 3746.5 3769.8 1029.1 1036.3 1043.9 1059.6 1077.8 12365.1 12479.8 12552.8 12563.3 12568.7 4086.5 4753.7 4861.2 4929.7 4962.3 8315.8 9903.9 9913.9 9924.0 9938.6 5636.0 5703.0 5711.9 5713.2 5716.7 4717.2 4743.0 4803.8 4856.1 5291.9 3308.7 3508.6 3996.0 4128.5 4149.7 1245.2 1267.7 1267.9 1276.9 1279.6 951.8 988.9 989.2 990.3 1018.4 6004.5 6154.0 6172.5 6205.4 6219.8 449.1 463.4 463.4 486.4 487.7 3996.9 4011.3 4073.0 4100.2 4169.2 11267.4 11627.5 11705.5 11838.5 11854.5 10438.3 11622.7 11624.5 11652.2 11684.2 7230.0 7997.7 8972.9 8982.8 9032.9 5938.3 5965.9 5983.6 6079.7 6107.6 10151.5 10404.3 10459.5 10462.9 10468.9 10147.8 10699.3 10845.2 10870.2 10870.5 7350.6 7409.5 7615.7 7992.0 7992.6 7450.7 8635.4 8736.5 8787.3 8806.4 7685.8 7798.8 7810.6 7851.7 7920.8 7545.9 7586.2 7659.6 7730.7 7739.5 7427.1 7486.3 7489.7 7502.7 7507.8 4969.1 4989.8 5087.9 5155.6 5179.1 5084.7 5129.9 5196.5 5197.0 5224.5 00:19:05 INFO - PROCESS | 6341 | 00:19:05 INFO - PROCESS | 6341 | [#4] prototype.html Cycles:180 Average:5788.22 Median:6578.99 stddev:1849.88 (28.1%) stddev-sans-first:1809.17 00:19:05 INFO - PROCESS | 6341 | Values: 332.0 336.8 340.1 346.2 346.3 5749.3 5908.9 6587.7 6599.2 6636.5 6541.2 6569.9 6570.3 6603.0 6618.7 4688.5 4872.1 4884.2 4898.2 4901.5 4821.8 4905.9 4930.7 4954.9 4956.2 4837.2 4881.7 4890.6 4894.2 4898.2 4696.1 4894.5 4895.6 4901.8 4917.3 4125.5 4231.6 4239.1 4252.8 4255.3 6266.7 6325.7 6341.0 6343.9 6380.8 4720.4 5807.3 5817.4 5818.0 5827.6 7006.6 7008.2 7018.2 7021.3 7028.6 4354.5 4538.2 4702.8 4714.0 4715.1 7269.3 7348.7 7376.0 7401.9 7433.3 4645.8 4646.0 4648.8 4659.1 4659.3 4724.7 4744.9 4751.6 4762.7 4763.8 5617.2 5617.6 5627.2 5630.1 5631.4 6727.7 7035.2 7041.8 7050.6 7055.9 1623.7 1634.7 1646.6 1647.8 1650.3 1026.2 1028.4 1048.0 1048.9 1050.5 5671.2 6516.3 6534.8 6658.8 6721.4 7160.2 7290.5 7330.0 7331.2 7381.7 6705.3 6763.5 6769.6 6771.7 6783.8 3862.4 3890.1 3898.7 3911.3 3912.5 7517.8 7796.0 7811.9 7815.1 7819.8 7527.4 7580.0 7584.1 7592.0 7604.3 7715.2 7772.6 7784.0 7789.5 7802.8 7020.8 7332.7 7341.5 7362.4 7385.3 5859.8 7200.6 7213.4 7223.6 7233.0 7647.2 7694.4 7701.5 7706.7 7725.1 4176.7 4676.0 4678.0 4705.7 4720.5 7336.9 7341.4 7342.9 7355.4 7358.3 6780.2 7079.5 7130.8 7133.4 7135.6 7028.3 7082.1 7092.6 7103.4 7113.4 5980.9 6646.3 6897.9 6913.5 6935.3 5907.6 6768.0 7016.0 7105.0 7119.3 6669.6 6886.7 6942.9 6970.8 6980.8 00:19:05 INFO - PROCESS | 6341 | 00:19:05 INFO - PROCESS | 6341 | [#5] yui.html Cycles:180 Average:18441.84 Median:26051.67 stddev:26010.88 (99.8%) stddev-sans-first:26050.00 00:19:05 INFO - PROCESS | 6341 | Values: 770.9 775.5 778.2 793.6 819.0 15127.3 15327.2 15444.5 15462.9 15463.8 14212.1 14428.0 14458.1 14462.7 14519.2 779.8 799.5 928.4 960.1 961.4 787.5 969.5 972.4 973.1 973.6 1013.1 1022.2 1022.5 1023.4 1024.3 811.1 990.1 1008.6 1015.0 1020.0 765.7 766.8 768.2 769.0 769.8 15349.3 15416.8 15444.8 15445.7 15468.3 12757.8 12819.7 13043.9 13099.6 13163.0 10240.6 10251.9 10285.4 10365.0 10728.6 3566.1 3577.2 3624.5 3665.2 3817.7 79648.6 81430.8 81760.0 81955.0 82060.0 8886.1 8969.5 9092.8 9167.0 9336.3 19126.9 19131.2 19156.1 19159.2 19186.4 7299.4 7448.4 7561.5 7587.8 7691.6 4154.1 4175.5 4260.0 4314.9 4432.8 3720.4 3761.4 3783.2 3784.5 3797.7 670.6 679.3 693.9 704.1 725.5 584.0 591.5 606.8 641.5 652.1 7832.5 8209.8 8302.5 8368.0 8459.9 507.6 582.3 606.0 620.9 624.8 3403.5 3482.3 3902.0 3967.0 3991.5 95470.0 97070.0 97793.0 98791.0 99022.5 76034.0 76615.5 77049.2 77207.8 81756.8 67863.0 70716.6 71806.0 71827.6 72898.6 8585.3 8696.6 8738.3 8766.4 8965.1 48637.0 48927.8 50366.1 50649.7 51595.7 51806.0 66366.0 67441.7 67690.3 67811.0 11068.4 11190.6 11203.2 11468.5 11700.4 11753.9 11827.7 12000.8 12055.0 12678.0 11593.7 11622.1 11638.2 11868.2 11896.2 11534.2 11611.5 11726.1 11752.9 11814.2 11390.8 11507.1 11545.9 11669.7 12263.0 9432.2 9462.9 9790.6 9869.3 9896.4 8468.3 9847.4 10033.9 10122.1 10145.8 00:19:05 INFO - PROCESS | 6341 | -------- Summary: end -------- 00:19:05 INFO - PROCESS | 6341 | 00:19:05 INFO - TEST-INFO | 6341: exit 0 00:19:05 INFO - TEST-OK | dromaeo_css | took 1113299ms 00:19:05 INFO - TEST-START | kraken 00:19:05 INFO - operating with platform_type : mac_ 00:19:05 INFO - Initialising browser for kraken test... 00:19:05 INFO - TEST-INFO | started process 6343 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/tmpN1MoK8/profile http://localhost:56990/getInfo.html) 00:19:08 INFO - PROCESS | 6343 | __metrics Screen width/height:1600/1200 00:19:08 INFO - PROCESS | 6343 | colorDepth:24 00:19:08 INFO - PROCESS | 6343 | Browser inner width/height: 1024/689 00:19:08 INFO - PROCESS | 6343 | __metrics 00:19:08 INFO - PROCESS | 6343 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:19:08 ERROR - PROCESS | 6343 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:19:08 INFO - TEST-INFO | 6343: exit 0 00:19:08 INFO - Browser initialized. 00:19:08 INFO - Running cycle 1/1 for kraken test... 00:19:08 INFO - TEST-INFO | started process 6346 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/tmpN1MoK8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:19:20 INFO - PROCESS | 6346 | RSS: Main: 160288768 00:19:20 INFO - PROCESS | 6346 | 00:19:23 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56990/tests/kraken/driver.html?testName=audio-beat-detection) 00:19:24 INFO - PROCESS | 6346 | RSS: Main: 223535104 00:19:24 INFO - PROCESS | 6346 | 00:19:26 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56990/tests/kraken/driver.html?testName=audio-dft) 00:19:27 INFO - PROCESS | 6346 | RSS: Main: 239542272 00:19:27 INFO - PROCESS | 6346 | 00:19:30 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56990/tests/kraken/driver.html?testName=audio-fft) 00:19:31 INFO - PROCESS | 6346 | RSS: Main: 327286784 00:19:31 INFO - PROCESS | 6346 | 00:19:33 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56990/tests/kraken/driver.html?testName=audio-oscillator) 00:19:33 INFO - PROCESS | 6346 | RSS: Main: 231337984 00:19:33 INFO - PROCESS | 6346 | 00:19:36 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56990/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:19:36 INFO - PROCESS | 6346 | RSS: Main: 233439232 00:19:36 INFO - PROCESS | 6346 | 00:19:39 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56990/tests/kraken/driver.html?testName=imaging-darkroom) 00:19:40 INFO - PROCESS | 6346 | RSS: Main: 271298560 00:19:40 INFO - PROCESS | 6346 | 00:19:42 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56990/tests/kraken/driver.html?testName=imaging-desaturate) 00:19:43 INFO - PROCESS | 6346 | RSS: Main: 272048128 00:19:43 INFO - PROCESS | 6346 | 00:19:46 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56990/tests/kraken/driver.html?testName=json-parse-financial) 00:19:46 INFO - PROCESS | 6346 | RSS: Main: 271622144 00:19:46 INFO - PROCESS | 6346 | 00:19:48 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56990/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:19:49 INFO - PROCESS | 6346 | RSS: Main: 259457024 00:19:49 INFO - PROCESS | 6346 | 00:19:50 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56990/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:19:51 INFO - PROCESS | 6346 | RSS: Main: 266018816 00:19:51 INFO - PROCESS | 6346 | 00:19:53 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56990/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:19:54 INFO - PROCESS | 6346 | RSS: Main: 270921728 00:19:54 INFO - PROCESS | 6346 | 00:19:57 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:19:57 INFO - PROCESS | 6346 | RSS: Main: 278179840 00:19:57 INFO - PROCESS | 6346 | 00:20:00 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:20:01 INFO - PROCESS | 6346 | RSS: Main: 275378176 00:20:01 INFO - PROCESS | 6346 | 00:20:02 INFO - PROCESS | 6346 | Cycle 1(1): loaded http://localhost:56990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56990/tests/kraken/driver.html?testName=ai-astar) 00:20:03 INFO - PROCESS | 6346 | RSS: Main: 336257024 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | __start_tp_report 00:20:03 INFO - PROCESS | 6346 | _x_x_mozilla_page_load 00:20:03 INFO - PROCESS | 6346 | _x_x_mozilla_page_load_details 00:20:03 INFO - PROCESS | 6346 | |i|pagename|runs| 00:20:03 INFO - PROCESS | 6346 | |0;ai-astar;113;112;114;113;112;114;112;113;115;136 00:20:03 INFO - PROCESS | 6346 | |1;audio-beat-detection;158;117;145;168;121;140;115;151;155;117 00:20:03 INFO - PROCESS | 6346 | |2;audio-dft;185;183;192;260;209;183;183;185;185;183 00:20:03 INFO - PROCESS | 6346 | |3;audio-fft;72;77;72;159;57;56;55;66;138;82 00:20:03 INFO - PROCESS | 6346 | |4;audio-oscillator;92;91;145;79;78;81;125;80;77;125 00:20:03 INFO - PROCESS | 6346 | |5;imaging-gaussian-blur;90;128;88;86;94;130;117;87;88;85 00:20:03 INFO - PROCESS | 6346 | |6;imaging-darkroom;92;93;93;94;92;94;93;94;93;94 00:20:03 INFO - PROCESS | 6346 | |7;imaging-desaturate;83;82;84;84;83;82;82;83;83;82 00:20:03 INFO - PROCESS | 6346 | |8;json-parse-financial;57;63;65;62;62;63;63;79;59;56 00:20:03 INFO - PROCESS | 6346 | |9;json-stringify-tinderbox;61;64;63;72;73;68;66;66;66;68 00:20:03 INFO - PROCESS | 6346 | |10;stanford-crypto-aes;74;103;102;103;76;79;83;78;82;84 00:20:03 INFO - PROCESS | 6346 | |11;stanford-crypto-ccm;128;137;141;127;122;124;124;128;147;140 00:20:03 INFO - PROCESS | 6346 | |12;stanford-crypto-pbkdf2;162;161;170;165;166;164;158;164;157;211 00:20:03 INFO - PROCESS | 6346 | |13;stanford-crypto-sha256-iterative;66;67;64;66;65;66;67;65;67;65 00:20:03 INFO - PROCESS | 6346 | __end_tp_report 00:20:03 INFO - PROCESS | 6346 | __start_cc_report 00:20:03 INFO - PROCESS | 6346 | _x_x_mozilla_cycle_collect,1915 00:20:03 INFO - PROCESS | 6346 | __end_cc_report 00:20:03 INFO - PROCESS | 6346 | __startTimestamp1468826403101__endTimestamp 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | ------- Summary: start ------- 00:20:03 INFO - PROCESS | 6346 | Number of tests: 14 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#0] ai-astar Cycles:10 Average:115.40 Median:113.50 stddev:7.31 (6.4%) stddev-sans-first:7.70 00:20:03 INFO - PROCESS | 6346 | Values: 113.0 112.0 114.0 113.0 112.0 114.0 112.0 113.0 115.0 136.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:148.00 stddev:19.74 (13.3%) stddev-sans-first:19.66 00:20:03 INFO - PROCESS | 6346 | Values: 158.0 117.0 145.0 168.0 121.0 140.0 115.0 151.0 155.0 117.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#2] audio-dft Cycles:10 Average:194.80 Median:185.00 stddev:24.28 (13.1%) stddev-sans-first:25.49 00:20:03 INFO - PROCESS | 6346 | Values: 185.0 183.0 192.0 260.0 209.0 183.0 183.0 185.0 185.0 183.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#3] audio-fft Cycles:10 Average:83.40 Median:69.00 stddev:35.83 (51.9%) stddev-sans-first:37.77 00:20:03 INFO - PROCESS | 6346 | Values: 72.0 77.0 72.0 159.0 57.0 56.0 55.0 66.0 138.0 82.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:79.50 stddev:24.86 (31.3%) stddev-sans-first:26.29 00:20:03 INFO - PROCESS | 6346 | Values: 92.0 91.0 145.0 79.0 78.0 81.0 125.0 80.0 77.0 125.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#5] imaging-gaussian-blur Cycles:10 Average:99.30 Median:87.50 stddev:18.20 (20.8%) stddev-sans-first:18.99 00:20:03 INFO - PROCESS | 6346 | Values: 90.0 128.0 88.0 86.0 94.0 130.0 117.0 87.0 88.0 85.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 00:20:03 INFO - PROCESS | 6346 | Values: 92.0 93.0 93.0 94.0 92.0 94.0 93.0 94.0 93.0 94.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#7] imaging-desaturate Cycles:10 Average:82.80 Median:83.00 stddev:0.79 (1.0%) stddev-sans-first:0.83 00:20:03 INFO - PROCESS | 6346 | Values: 83.0 82.0 84.0 84.0 83.0 82.0 82.0 83.0 83.0 82.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:6.35 (10.1%) stddev-sans-first:6.37 00:20:03 INFO - PROCESS | 6346 | Values: 57.0 63.0 65.0 62.0 62.0 63.0 63.0 79.0 59.0 56.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:3.74 (5.6%) stddev-sans-first:3.35 00:20:03 INFO - PROCESS | 6346 | Values: 61.0 64.0 63.0 72.0 73.0 68.0 66.0 66.0 66.0 68.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:78.50 stddev:11.64 (14.8%) stddev-sans-first:11.44 00:20:03 INFO - PROCESS | 6346 | Values: 74.0 103.0 102.0 103.0 76.0 79.0 83.0 78.0 82.0 84.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:132.50 stddev:8.69 (6.6%) stddev-sans-first:9.11 00:20:03 INFO - PROCESS | 6346 | Values: 128.0 137.0 141.0 127.0 122.0 124.0 124.0 128.0 147.0 140.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:164.50 stddev:15.65 (9.5%) stddev-sans-first:16.46 00:20:03 INFO - PROCESS | 6346 | Values: 162.0 161.0 170.0 165.0 166.0 164.0 158.0 164.0 157.0 211.0 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - PROCESS | 6346 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 00:20:03 INFO - PROCESS | 6346 | Values: 66.0 67.0 64.0 66.0 65.0 66.0 67.0 65.0 67.0 65.0 00:20:03 INFO - PROCESS | 6346 | -------- Summary: end -------- 00:20:03 INFO - PROCESS | 6346 | 00:20:03 INFO - TEST-INFO | 6346: exit 0 00:20:03 INFO - TEST-OK | kraken | took 58030ms 00:20:03 INFO - SUITE-END | took 1171s 00:20:04 INFO - Completed test suite (00:19:31) 00:20:04 INFO - javascript benchmark 00:20:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3286.9835650821747, 3529.717622590192, 3564.260021065601, 3570.9464358034634, 3645.562532496101, 5914.260717410324, 5954.196183515224, 5959.731812068457, 5965.164876917235, 5986.311574168977, 5965.850853728659, 5992.580519363646, 5998.100284957248, 5998.220231369926, 6026.608270462428, 5301.787928482875, 5327.653702509344, 5420.647657902224, 5452.754626041818, 5500.28496295483, 5402.486763757456, 5437.102878025121, 5437.483439073281, 5443.0, 5444.020076386249, 5384.219288203209, 5426.158945363475, 5431.511163995239, 5446.91829622556, 5461.0716178249795, 5448.128299472105, 5476.780928762844, 5480.342358916916, 5496.31296087989, 5517.503424691757, 5283.365996080456, 5313.867153321159, 5379.273798037254, 5391.595630327741, 5395.460453954613, 5729.8567535811935, 5730.570207234432, 5760.3951585083805, 5793.333766616851, 5871.79448719297, 6279.780207692755, 6293.056041593752, 6300.59046161998, 6301.558890877641, 6304.432601065881, 6213.627182369072, 6326.08271800591, 6358.586691865014, 6360.52296077796, 6377.394147555975, 5979.940200597982, 6049.885719964208, 6068.274312698971, 6103.572749907553, 6117.785877494311, 6496.70764815575, 6508.0, 6515.087887695727, 6532.706028228741, 6538.574992625464, 6167.259928808482, 6262.0, 6274.498040156868, 6288.056791481223, 6302.149209856702, 6233.812985610439, 6297.779577714849, 6326.6520341381665, 6405.583637063576, 6431.13179720741, 5478.616496845262, 6120.969395152996, 6258.812235632848, 6275.937240627627, 6281.246250449975, 6178.208319587359, 6251.937480625135, 6261.24865016201, 6269.8746025079245, 6303.873922521524, 4963.156263435225, 5024.145895197752, 5027.673201241908, 5081.212412076134, 5117.130087885069, 4572.0, 4584.9541504585195, 4595.2188128018315, 4600.608948239437, 4625.352450656911, 6086.2696476422225, 6098.1157732128595, 6105.633661980207, 6126.9387306127255, 6155.784547540815, 5142.6400151989, 5520.282363292747, 6206.441420272197, 6288.276848162428, 6321.367863213642, 6082.270127584629, 6107.931112055373, 6110.792407652138, 6119.380693981147, 6123.418275263843, 5560.582956278296, 5595.468430499096, 5601.859953501195, 5610.719464026783, 5616.213730077792, 6452.22573291208, 6522.380373864476, 6626.966865165643, 6649.301823308483, 6656.467482601477, 6367.076773867856, 6392.776252831129, 6394.872102558016, 6404.583702059351, 6419.839504012437, 6555.541112122296, 6614.305497922841, 6619.933800662125, 6624.867502650017, 6629.834254143685, 6183.288921774054, 6244.2819075806865, 6306.369363063657, 6313.65274909866, 6323.905141422974, 6346.714397852015, 6356.046593011085, 6361.2048493938255, 6364.427201551883, 6370.840728981627, 6154.230721159855, 6172.9074063889975, 6240.12638230639, 6252.187215661935, 6283.842903927439, 6160.753569857335, 6201.348858369806, 6244.5316601256, 6259.186305780219, 6266.624002559861, 6130.0, 6137.877242455215, 6141.815745527641, 6160.7535698571555, 6214.782482613087, 6123.282621474203, 6148.938510615016, 6204.968975155095, 6235.251769787655, 6249.96875015622, 6157.014877619559, 6203.596766210182, 6223.968880155751, 6234.594751341148, 6244.65654389013], "value": 5872.283114386877, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.3084052412913, 541.5045233611245, 570.2387312937228, 575.1975993489085, 617.0035392840562, 32326.19184520388, 32961.67038329616, 40147.19705605886, 40773.796131019306, 40891.18217635646, 44057.0, 44412.55587444125, 44522.777386113106, 44608.10783784322, 44612.776936115355, 9679.080487353707, 9882.0, 9890.357126786736, 9892.406455612687, 9895.158911492532, 9259.675911343104, 9450.574724137396, 9452.716418507422, 9461.479618620973, 11901.523939042429, 11882.524699012029, 11958.701032474215, 11960.222585531956, 11961.641150765447, 11975.221610595283, 9821.558029888636, 11882.10884183681, 11957.820632690517, 11959.641210763692, 11972.221805582609, 11768.588099416565, 11869.762604747943, 11888.881111188864, 11897.464614092387, 11914.582989595408, 40448.79775601133, 40950.795246023874, 41051.7947410264, 43241.56758432407, 43301.91745206364, 2841.687414384416, 3291.0, 3467.7052450541732, 3726.850925962958, 3830.865919692825, 29169.416611667646, 29647.55528667072, 30431.847840760875, 31192.37615247705, 31388.901388451293, 2739.5479745842113, 2746.32714984828, 2755.200991712401, 2797.1888152435768, 2848.6011958325853, 510453.0, 510890.0, 512609.0, 512737.9999999963, 513096.0, 37370.81314593464, 38336.0, 68631.31368686349, 69097.65451172712, 69128.0, 37142.0, 37391.0, 37482.625173748456, 37529.43705844414, 37537.06157346088, 13692.0, 16549.751753723704, 16552.00687958702, 16562.0, 16568.420105296256, 14428.495002674856, 14498.492552760603, 14516.85483145155, 14535.345909434101, 14539.491117810825, 8077.474964127313, 8248.422610417214, 8535.95732021336, 8641.611127499278, 8703.564821758886, 3458.844352004166, 3551.076720052805, 3555.093451169987, 3561.732870034758, 3613.9638603614153, 887.5029983209423, 1017.2624846985876, 1065.4619417194267, 1068.0974576482859, 1123.07346439188, 28818.392266346236, 29716.55425168624, 29931.40137197244, 30362.0, 30368.93708720184, 831.8918540589684, 1091.7980173667897, 1111.1166622535104, 1170.584442522892, 1228.3305598448867, 11043.779124417628, 16552.75170872438, 17146.314147434212, 17166.485005449857, 17227.3970411035, 635045.0, 642430.0, 643749.0, 646141.0, 647819.0, 66855.66572167107, 67368.66315668488, 67603.32396676068, 67710.66144669344, 67761.32238677649, 1264.9683757906125, 1445.6747231872955, 1482.5626440200167, 1594.2985086561876, 1612.0569466862016, 24418.75581244236, 28982.13053608395, 30069.849650751607, 30790.0, 30903.69096309008, 52464.21303680524, 53359.0, 53377.4662253388, 53445.46554534561, 53496.0, 425492.0, 432410.0, 432737.0, 432780.0, 433201.0, 44030.779846100566, 44503.332450012625, 46523.53476465192, 46665.76667116643, 48434.27348589845, 47650.80688381987, 47817.76091119522, 47825.76087119542, 48521.27218091661, 48747.75626121847, 39147.2170556593, 39685.801570991964, 39836.0, 40007.59992400155, 40306.1938761229, 32831.50752738663, 38911.80544097262, 39192.0, 39266.214675705756, 39453.40819887647, 39233.0, 39406.0, 39735.80132099437, 39991.0, 40049.0, 30349.48252587406, 33083.669163308055, 34350.312993739484, 35613.0, 37145.442818358286, 25757.0, 26009.0, 26066.60900086538, 26507.204783856516, 26598.93604255808], "value": 19658.867514573933, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.89761508430433, 418.1845401467139, 418.27638185938343, 420.74124413485714, 427.9721818081824, 17526.561835954108, 20369.592608147846, 21019.684704729403, 21039.894800525995, 22370.66444003337, 12283.508659653604, 12581.119321647466, 14461.855381446183, 21336.679949800764, 21368.931553422346, 5095.133827249358, 5364.7317634118335, 5536.892621475721, 5617.719114044302, 5648.01159797036, 5020.995800839828, 6161.568690191689, 6199.876002479948, 6237.781677641284, 6240.906386404207, 5600.859978500529, 5600.971995140039, 6198.070289456595, 6216.37836216377, 6216.378362163793, 5541.778328866861, 5575.470330318613, 5593.468620481048, 5608.383077861432, 5608.691521966311, 5211.42674305826, 5449.291592093003, 5455.427180146067, 5468.48049435303, 5510.173473978895, 14282.785758213635, 14302.213378264192, 21066.94665266746, 26614.33464163392, 26966.92132314705, 2062.669972804359, 2172.880491572963, 2258.8691796008916, 2337.100216416675, 2840.957385639217, 10080.0, 10496.265261431703, 10767.946160269226, 13076.019298552646, 14907.850921490755, 1807.7107662774024, 1824.0606087864628, 1849.6208277303122, 1851.139220262571, 1902.077492416177, 121516.39241803734, 124323.37838310932, 127291.0, 127410.0, 130750.0, 11758.706032349088, 11911.166218364631, 11916.523339066514, 11960.58137965167, 12030.4586293617, 15802.288896999662, 15850.0, 15868.761968570481, 15887.046777193405, 15888.443904463289, 8146.470479418819, 9280.02559731232, 9318.347715659838, 9406.858897116548, 9418.717438476857, 9411.90588094124, 9444.95277523608, 9461.0, 9461.858072128924, 9559.0, 4799.5601319604675, 4803.95196048042, 4822.71063736177, 4840.588549973291, 4856.587190088811, 2008.3590079046007, 2064.7081739269397, 2097.863638863469, 2103.7475502939437, 2115.3865379039908, 1001.3040936549029, 1040.2627611888165, 1044.2637940252105, 1051.358671210561, 1120.9159313051555, 21143.471413214484, 21551.56896862054, 21656.56686866254, 21867.453313667287, 21947.451313717283, 994.5971881387904, 1018.1244130048152, 1021.0963297481782, 1066.9199810014125, 1089.7330154112294, 10749.0, 11685.824712629317, 11687.0, 11720.120990925714, 11721.706957325965, 408061.0, 484633.0, 488902.0, 500675.0, 654825.0, 80100.59949700214, 126412.36793815972, 129914.35042824726, 142592.28703856413, 144542.27728861498, 1052.489542571852, 1065.1053115383115, 1090.9945450272858, 1098.6813823990954, 1102.4653043274006, 14956.476523321631, 18503.907480462512, 18853.811461885205, 18937.863728176355, 19156.0, 55216.723916380164, 55593.88812223814, 55846.44153558413, 56493.8701225965, 57389.85220295487, 84135.0, 86181.0, 87364.0, 87418.88067835191, 88843.0, 7990.440669153103, 8080.151584083586, 8192.713255036046, 8222.876656850272, 8480.703175388831, 7296.015037969806, 7543.660535275816, 10158.831734350644, 11314.773704525698, 12631.557895473614, 11151.498182581965, 11236.325820450798, 11355.0, 11506.712332191762, 11619.302841829518, 11061.446927653424, 11078.058365039062, 11095.22333436684, 11260.493277802683, 11341.943290283496, 11214.551847449162, 11579.88420115788, 11583.6524904253, 11904.0, 11950.581729639422, 8305.086440491421, 8540.572971351532, 8576.44253123545, 8606.956965215133, 8779.385443019182, 10459.47702614851, 10610.734731631772, 11509.366984815915, 11647.59233426826, 11660.591879284184], "value": 9703.890112750878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.043722673329, 1635.0516700313817, 1667.866570674346, 1977.6835706286997, 2067.66917293233, 8418.494890306578, 8982.86525702115, 9139.360244782867, 9142.222911052551, 9148.862767058492, 7288.635568221581, 9263.397879137869, 9265.444073355604, 9283.210927071206, 9306.162445379914, 2566.640670306154, 2593.455374371384, 2594.2995391244353, 2594.624848830123, 2599.155274535774, 2517.8237523373373, 2578.40696639773, 2583.173384516946, 2586.6249393837884, 2587.935301617456, 2531.848089114659, 2567.845929244242, 2568.4092658688514, 2579.767820896119, 2581.2514370832437, 2535.581629031217, 2574.4078861861785, 2575.8840852161698, 2579.948401031969, 2580.58710606303, 2523.4574566468295, 2563.8974441022337, 2572.884220210095, 2573.137998770414, 2578.6776652918384, 9030.367874248805, 9353.812923741487, 9432.811343773155, 9436.245100391952, 9438.244940404751, 5798.985177593946, 5947.1971283876555, 5972.193753843219, 6008.218931538872, 6025.668588227646, 3624.966884437949, 3710.2950439416422, 3744.981275093607, 3746.4942232798494, 3769.792661403622, 1029.1321251927727, 1036.2797855490437, 1043.8695163104612, 1059.6132411669762, 1077.849101125843, 12365.07261955357, 12479.75040499185, 12552.81170782439, 12563.309018004005, 12568.74862502754, 4086.5300490443383, 4753.718215256627, 4861.222204447272, 4929.654924155347, 4962.280469331999, 8315.750527484186, 9903.900960990299, 9913.851292230622, 9924.0, 9938.552765125587, 5636.013697602903, 5702.971485142548, 5711.8857622848145, 5713.228714123623, 5716.685582292931, 4717.198076327033, 4742.9762851186215, 4803.78382972767, 4856.077345304381, 5291.894162116736, 3308.718758905472, 3508.614052454228, 3996.0009997500624, 4128.4632997710105, 4149.688773341951, 1245.2404033539533, 1267.66406902171, 1267.8985681145487, 1276.8723127687342, 1279.649969282416, 951.7810903492235, 988.9270141895979, 989.2333441582687, 990.2968892086699, 1018.4195008844887, 6004.459598636144, 6154.046122850876, 6172.537059720539, 6205.441510264008, 6219.751209951642, 449.1354143274184, 463.40221114762255, 463.4253525628197, 486.43087587522683, 487.663512176597, 3996.8800935971967, 4011.3180759270995, 4072.959270407258, 4100.159467309194, 4169.207850508394, 11267.38029408374, 11627.53489860413, 11705.473253703603, 11838.526458941718, 11854.466549005316, 10438.321509101885, 11622.70943226426, 11624.476898539586, 11652.242604230698, 11684.240524365889, 7229.963850180716, 7997.6800927963395, 8972.910270897339, 8982.820343593223, 9032.909670903338, 5938.257717785277, 5965.940340596712, 5983.611065280743, 6079.726412311368, 6107.633541987495, 10151.543180556744, 10404.271700980858, 10459.477026148814, 10462.94768526183, 10468.895311046792, 10147.847782283125, 10699.304545204848, 10845.186611004048, 10870.239083264096, 10870.510827012646, 7350.595717235603, 7409.518381305198, 7615.6953721850505, 7991.960040199761, 7992.560409177318, 7450.664720087718, 8635.352348574008, 8736.475811451333, 8787.297016238814, 8806.383553151474, 7685.807854803675, 7798.844023119393, 7810.609469526615, 7851.725189618564, 7920.801979950317, 7545.886811697938, 7586.203448637813, 7659.578723170279, 7730.652120654471, 7739.535627862347, 7427.071616047994, 7486.326230639269, 7489.66296516669, 7502.699892004259, 7507.812304692208, 4969.105560999054, 4989.775460104232, 5087.898242035065, 5155.561777248976, 5179.067767801681, 5084.720340381315, 5129.897402052013, 5196.454372291007, 5197.0, 5224.451432599522], "value": 4714.765141394656, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.9668033196681, 336.81306874684554, 340.0766917818124, 346.24518549561947, 346.2952890867086, 5749.281339832521, 5908.852278693035, 6587.7035533400995, 6599.208095028597, 6636.50226233032, 6541.215054193492, 6569.883119869622, 6570.277269500351, 6603.042558828979, 6618.702158402872, 4688.507706690791, 4872.147374209517, 4884.194107972198, 4898.167311557044, 4901.509849015106, 4821.831235906744, 4905.8773530661665, 4930.654854160192, 4954.925676114861, 4956.1822299320565, 4837.153498137829, 4881.682690625098, 4890.584300334458, 4894.167991441445, 4898.216285394337, 4696.084263568606, 4894.535019173209, 4895.608351331903, 4901.779419926112, 4917.2869933859565, 4125.50493940729, 4231.555686652919, 4239.0885959518855, 4252.829886804555, 4255.340422234528, 6266.652669675996, 6325.652089135096, 6341.0, 6343.936560634381, 6380.776672816429, 4720.433547974265, 5807.344906701612, 5817.447342502455, 5818.0400233961345, 5827.592068555203, 7006.579605223703, 7008.159020917472, 7018.192907815615, 7021.332973367522, 7028.648567571601, 4354.54277300882, 4538.183127037132, 4702.788374523155, 4713.976430117862, 4715.104130215248, 7269.345758881726, 7348.742794002184, 7376.0411146550605, 7401.888971665429, 7433.293837085523, 4645.814167433265, 4646.0, 4648.790804413809, 4659.1147681941, 4659.254519276899, 4724.669273150916, 4744.857654270378, 4751.6436267279405, 4762.738049407247, 4763.833265835679, 5617.241672374259, 5617.578681598815, 5627.184058311522, 5630.127330263816, 5631.352394474688, 6727.663616819237, 7035.155781306276, 7041.788746337618, 7050.612216328049, 7055.9294407056295, 1623.7077326081182, 1634.730269505542, 1646.5801220688647, 1647.8022637283364, 1650.290375138678, 1026.1893104447404, 1028.3675539543126, 1047.9685609431729, 1048.8951104889602, 1050.5482642463662, 5671.234383358276, 6516.283208847023, 6534.836629084216, 6658.766943156967, 6721.395074443323, 7160.212376638566, 7290.489665723455, 7329.963350183321, 7331.230220826843, 7381.66782494789, 6705.329467053353, 6763.458923286125, 6769.593824370455, 6771.72913083481, 6783.796486105425, 3862.439946207784, 3890.124721937598, 3898.7465814721954, 3911.2764138634443, 3912.5304963404005, 7517.849643007218, 7795.961020194863, 7811.882821757678, 7815.101263354673, 7819.804504887309, 7527.360174385239, 7579.962100189464, 7584.051993500812, 7592.0, 7604.315611594983, 7715.1899050600005, 7772.57250851186, 7783.961080194563, 7789.493682910706, 7802.765917022499, 7020.824479387852, 7332.706691732271, 7341.522801017917, 7362.3741981932135, 7385.261473852572, 5859.824205273849, 7200.639968001684, 7213.3868621167785, 7223.638818058971, 7232.963835181001, 7647.158812530728, 7694.384449244159, 7701.460897737329, 7706.653200605874, 7725.072991241087, 4176.749395036308, 4675.953240467552, 4678.041001594597, 4705.682408925506, 4720.4807471177455, 7336.853262934818, 7341.4126869849215, 7342.853142937218, 7355.374793142642, 7358.300961408658, 6780.220274668279, 7079.539829911039, 7130.8217294565975, 7133.3936615388275, 7135.571865687868, 7028.262032486719, 7082.114735658043, 7092.574445533284, 7103.360697537247, 7113.430925526049, 5980.910286345796, 6646.268910419753, 6897.862042759217, 6913.51605387618, 6935.306469353024, 5907.586468947305, 6767.966160169168, 7015.964920175366, 7105.005299258211, 7119.288071192839, 6669.599824010575, 6886.69009894566, 6942.895856562257, 6970.79087627372, 6980.7905762827195], "value": 5170.415018847419, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.9383249340053, 775.495927647029, 778.1906816910414, 793.5516433215234, 818.9590520473977, 15127.319270632821, 15327.157006364645, 15444.459443919464, 15462.922685386586, 15463.845361546395, 14212.076215046041, 14428.0, 14458.132512049284, 14462.710745785078, 14519.20144392058, 779.8479296537178, 799.476342995339, 928.4290161550631, 960.135877710063, 961.4135377419768, 787.4684587903171, 969.5103972493881, 972.3776782858976, 973.1339108193713, 973.5570315506427, 1013.0882206014572, 1022.2384323678832, 1022.5091955861154, 1023.3706270643574, 1024.3137098144261, 811.059171361221, 990.0891180114312, 1008.6167256442578, 1014.9746256343576, 1019.9694009179736, 765.7243392378739, 766.789132988427, 768.1780494870435, 769.0156599552581, 769.8421823526164, 15349.309281082267, 15416.845831541654, 15444.845551544566, 15445.691086178325, 15468.30392632323, 12757.808632870514, 12819.743605127938, 13043.86956130436, 13099.607011789662, 13163.0, 10240.590376384936, 10251.89748102517, 10285.434301113435, 10365.0, 10728.624498142528, 3566.144125409909, 3577.2130131371055, 3624.4925710400566, 3665.21197942441, 3817.6945844332386, 79648.60175699084, 81430.77853832138, 81760.0, 81955.0, 82060.0, 8886.066962968924, 8969.50667713269, 9092.81814363709, 9166.954165229132, 9336.299777516713, 19126.904365478083, 19131.23475060982, 19156.137973791214, 19159.233630654617, 19186.424407267805, 7299.41604671625, 7448.366888814403, 7561.508501947355, 7587.772366829004, 7691.5769632670745, 4154.065335299533, 4175.519815221289, 4260.0, 4314.870553883388, 4432.778361081998, 3720.3861362874823, 3761.3793724035777, 3783.243351329745, 3784.4890939723336, 3797.6771974382486, 670.6345041952147, 679.2765704524666, 693.8716337477583, 704.0530486495655, 725.4957804325943, 584.0334246821517, 591.4617697894895, 606.7876243314804, 641.5060403489288, 652.1228947066188, 7832.530048197126, 8209.753707388787, 8302.460340077876, 8368.0, 8459.873101903477, 507.59138893191334, 582.2954225387329, 605.9545534084962, 620.8789286089169, 624.7563450254404, 3403.540522029544, 3482.2861313431195, 3901.96098039016, 3966.960330396717, 3991.4811074560703, 95470.0452995475, 97070.0, 97793.02413198276, 98791.0, 99022.50488747511, 76034.0, 76615.46769064698, 77049.2295077042, 77207.84188237181, 81756.77364839532, 67862.98205526921, 70716.64641676759, 71806.0, 71827.64086179536, 72898.6355068232, 8585.313174946114, 8696.565171741515, 8738.300935925237, 8766.386352955487, 8965.135031230206, 48637.0, 48927.75536122297, 50366.134667579594, 50649.74675126601, 51595.742021289654, 51806.0, 66366.0, 67441.65116697736, 67690.3230967684, 67811.0, 11068.391238481961, 11190.552377905118, 11203.21577489568, 11468.483918223867, 11700.425906300601, 11753.882461175279, 11827.704307392383, 12000.75998480043, 12055.035597152382, 12678.0, 11593.710157246136, 11622.128340374336, 11638.243514171552, 11868.169228153947, 11896.167268291136, 11534.1926065178, 11611.5355385787, 11726.120540959291, 11752.941235293769, 11814.232074915102, 11390.772184556097, 11507.136964727511, 11545.88454115448, 11669.708257293636, 12263.0, 9432.151106400457, 9462.858057129011, 9790.559424826042, 9869.259805514472, 9896.406215627085, 8468.280196183394, 9847.409155450696, 10033.943041676584, 10122.089011988955, 10145.797084058426], "value": 7053.354881561557, "unit": "score"}], "name": "dromaeo_css", "value": 7599.552587421724, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 114.0, 113.0, 112.0, 114.0, 112.0, 113.0, 115.0, 136.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 117.0, 145.0, 168.0, 121.0, 140.0, 115.0, 151.0, 155.0, 117.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 192.0, 260.0, 209.0, 183.0, 183.0, 185.0, 185.0, 183.0], "value": 194.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 77.0, 72.0, 159.0, 57.0, 56.0, 55.0, 66.0, 138.0, 82.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 145.0, 79.0, 78.0, 81.0, 125.0, 80.0, 77.0, 125.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 128.0, 88.0, 86.0, 94.0, 130.0, 117.0, 87.0, 88.0, 85.0], "value": 99.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 94.0, 92.0, 94.0, 93.0, 94.0, 93.0, 94.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 84.0, 83.0, 82.0, 82.0, 83.0, 83.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 65.0, 62.0, 62.0, 63.0, 63.0, 79.0, 59.0, 56.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 63.0, 72.0, 73.0, 68.0, 66.0, 66.0, 66.0, 68.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 103.0, 102.0, 103.0, 76.0, 79.0, 83.0, 78.0, 82.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 137.0, 141.0, 127.0, 122.0, 124.0, 124.0, 128.0, 147.0, 140.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 170.0, 165.0, 166.0, 164.0, 158.0, 164.0, 157.0, 211.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 64.0, 66.0, 65.0, 66.0, 67.0, 65.0, 67.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1486.2999999999997, "alertThreshold": 2.0}]} 00:20:04 INFO - Return code: 0 00:20:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:20:04 ERROR - # TBPL SUCCESS # 00:20:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:20:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:20:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:20:04 INFO - 2016-07-18 00:20:04.395 screenresolution[6350:110712] starting screenresolution argv=screenresolution get 00:20:04 INFO - 2016-07-18 00:20:04.397 screenresolution[6350:110712] Display 0: 1600x1200x32@60 00:20:04 INFO - 2016-07-18 00:20:04.403 screenresolution[6351:110715] starting screenresolution argv=screenresolution list 00:20:04 INFO - Available Modes on Display 0 00:20:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:20:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:20:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:20:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:20:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:20:04 INFO - Intel Iris: 00:20:04 INFO - Chipset Model: Intel Iris 00:20:04 INFO - Type: GPU 00:20:04 INFO - Bus: Built-In 00:20:04 INFO - VRAM (Dynamic, Max): 1536 MB 00:20:04 INFO - Vendor: Intel (0x8086) 00:20:04 INFO - Device ID: 0x0a2e 00:20:04 INFO - Revision ID: 0x0009 00:20:04 INFO - Displays: 00:20:04 INFO - Display: 00:20:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:20:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:20:04 INFO - Display Serial Number: 1600x1200 60 00:20:04 INFO - Main Display: Yes 00:20:04 INFO - Mirror: Off 00:20:04 INFO - Online: Yes 00:20:04 INFO - Rotation: Supported 00:20:04 INFO - Return code: 0 00:20:04 INFO - Running post-action listener: _resource_record_post_action 00:20:04 INFO - Running post-run listener: _resource_record_post_run 00:20:05 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 1510912; Write bytes: 495426048; Read time: 19; Write time: 1547 00:20:05 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194673152; Write bytes: 197379584; Read time: 17504; Write time: 447 00:20:05 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 1486336; Write bytes: 297198592; Read time: 18; Write time: 1096 00:20:05 INFO - Running post-run listener: _upload_blobber_files 00:20:05 INFO - Blob upload gear active. 00:20:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:20:05 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 00:20:05 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'] 00:20:05 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 00:20:06 INFO - (blobuploader) - INFO - Open directory for files ... 00:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:20:07 INFO - (blobuploader) - INFO - Done attempting. 00:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:20:08 INFO - (blobuploader) - INFO - Done attempting. 00:20:08 INFO - (blobuploader) - INFO - Iteration through files over. 00:20:08 INFO - Return code: 0 00:20:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:20:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:20:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7cd3b3e67e66fe37afd9952b7e76ae1ff1a71ac2e95e01dbb015da68ed917e6b4ddea162be2fea90475b1c63c6cf687855e3211602bdfda9dfff0b74d17b2cf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8135ff7e6a37ae9ce6d7610053e713b755bc1c2d935f63accb6fb339b18debd65737a29e95fe7a4177c09f96062f4737e365e6bc63517a8c52475294cd552af2"} 00:20:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:20:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:20:08 INFO - Contents: 00:20:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7cd3b3e67e66fe37afd9952b7e76ae1ff1a71ac2e95e01dbb015da68ed917e6b4ddea162be2fea90475b1c63c6cf687855e3211602bdfda9dfff0b74d17b2cf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8135ff7e6a37ae9ce6d7610053e713b755bc1c2d935f63accb6fb339b18debd65737a29e95fe7a4177c09f96062f4737e365e6bc63517a8c52475294cd552af2"} 00:20:08 INFO - Running post-run listener: copy_logs_to_upload_dir 00:20:08 INFO - Copying logs to upload dir... 00:20:08 INFO - mkdir: /builds/slave/test/build/upload/logs 00:20:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.632819 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-18 00:20:08.325792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 00:20:08.329235) ========= 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.ShkImyusqo/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.OrJ2y269I0/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7cd3b3e67e66fe37afd9952b7e76ae1ff1a71ac2e95e01dbb015da68ed917e6b4ddea162be2fea90475b1c63c6cf687855e3211602bdfda9dfff0b74d17b2cf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8135ff7e6a37ae9ce6d7610053e713b755bc1c2d935f63accb6fb339b18debd65737a29e95fe7a4177c09f96062f4737e365e6bc63517a8c52475294cd552af2"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011320 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468664157/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7cd3b3e67e66fe37afd9952b7e76ae1ff1a71ac2e95e01dbb015da68ed917e6b4ddea162be2fea90475b1c63c6cf687855e3211602bdfda9dfff0b74d17b2cf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8135ff7e6a37ae9ce6d7610053e713b755bc1c2d935f63accb6fb339b18debd65737a29e95fe7a4177c09f96062f4737e365e6bc63517a8c52475294cd552af2"}' ========= master_lag: 0.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 00:20:08.527162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 00:20:08.527515) ========= 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.ShkImyusqo/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.OrJ2y269I0/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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.005322 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 00:20:08.618562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 00:20:08.618883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 00:20:08.619170) ========= ========= Total master_lag: 1.98 =========