builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0009 starttime: 1468619539.69 results: success (0) buildid: 20160712111957 builduid: 7d6176452a1c4b7b8f7d2f9d47b9e21f revision: 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:19.687069) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:19.687769) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:19.688037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:19.710728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:19.711069) ========= 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.eaPq3bscuQ/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.7i1zLToSSA/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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-15 14:52:19-- 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% 11.6M=0.001s 2016-07-15 14:52:19 (11.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079440 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:19.812141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:19.812464) ========= 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.eaPq3bscuQ/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.7i1zLToSSA/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.021350 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:19.860902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 14:52:19.862188) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 --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 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eaPq3bscuQ/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.7i1zLToSSA/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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-15 14:52:19,937 truncating revision to first 12 chars 2016-07-15 14:52:19,937 Setting DEBUG logging. 2016-07-15 14:52:19,937 attempt 1/10 2016-07-15 14:52:19,937 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1748a233dae0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 14:52:20,760 unpacking tar archive at: mozilla-beta-1748a233dae0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.075733 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 14:52:20.961235) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:20.961662) ========= script_repo_revision: 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:20.962387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:20.962836) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 14:52:20.981997) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-15 14:52:20.982417) ========= /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.eaPq3bscuQ/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.7i1zLToSSA/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:52:21 INFO - MultiFileLogger online at 20160715 14:52:21 in /builds/slave/test 14:52: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 14:52:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:52:21 INFO - {'append_to_log': False, 14:52:21 INFO - 'base_work_dir': '/builds/slave/test', 14:52:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:52:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:52:21 INFO - 'branch': 'Mozilla-Beta', 14:52:21 INFO - 'buildbot_json_path': 'buildprops.json', 14:52:21 INFO - 'config_files': ('talos/mac_config.py',), 14:52:21 INFO - 'default_actions': ('clobber', 14:52:21 INFO - 'read-buildbot-config', 14:52:21 INFO - 'download-and-extract', 14:52:21 INFO - 'populate-webroot', 14:52:21 INFO - 'create-virtualenv', 14:52:21 INFO - 'install', 14:52:21 INFO - 'run-tests'), 14:52:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:52:21 INFO - 'download_minidump_stackwalk': True, 14:52:21 INFO - 'download_symbols': 'ondemand', 14:52:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:52:21 INFO - 'tooltool.py': '/tools/tooltool.py', 14:52:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:52:21 INFO - '/tools/misc-python/virtualenv.py')}, 14:52:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:52:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:52:21 INFO - 'installer_path': 'installer.exe', 14:52:21 INFO - 'log_level': 'info', 14:52:21 INFO - 'log_name': 'talos', 14:52:21 INFO - 'log_to_console': True, 14:52:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:52:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:52:21 INFO - 'opt_config_files': (), 14:52:21 INFO - 'pip_index': False, 14:52:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:52:21 INFO - 'cmd': ('bash', 14:52:21 INFO - '-c', 14:52:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:52:21 INFO - 'enabled': True, 14:52:21 INFO - 'halt_on_failure': False, 14:52:21 INFO - 'name': 'check_screen_resolution'},), 14:52:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:52:21 INFO - 'cmd': ('bash', 14:52:21 INFO - '-c', 14:52:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:52:21 INFO - 'enabled': True, 14:52:21 INFO - 'halt_on_failure': False, 14:52:21 INFO - 'name': 'check_screen_resolution'},), 14:52:21 INFO - 'run_cmd_checks_enabled': True, 14:52:21 INFO - 'sps_profile': False, 14:52:21 INFO - 'sps_profile_interval': 0, 14:52:21 INFO - 'suite': 'dromaeojs', 14:52:21 INFO - 'system_bits': '32', 14:52:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:52:21 INFO - 'title': 't-yosemite-r7-0009', 14:52:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:52:21 INFO - 'use_talos_json': True, 14:52:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:52:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:52:21 INFO - 'work_dir': 'build'} 14:52:21 INFO - ##### 14:52:21 INFO - ##### Running clobber step. 14:52:21 INFO - ##### 14:52:21 INFO - Running pre-action listener: _resource_record_pre_action 14:52:21 INFO - Running main action method: clobber 14:52:21 INFO - rmtree: /builds/slave/test/build 14:52:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:52:22 INFO - Running post-action listener: _resource_record_post_action 14:52:22 INFO - ##### 14:52:22 INFO - ##### Running read-buildbot-config step. 14:52:22 INFO - ##### 14:52:22 INFO - Running pre-action listener: _resource_record_pre_action 14:52:22 INFO - Running main action method: read_buildbot_config 14:52:22 INFO - Using buildbot properties: 14:52:22 INFO - { 14:52:22 INFO - "project": "", 14:52:22 INFO - "product": "firefox", 14:52:22 INFO - "script_repo_revision": "production", 14:52:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:52:22 INFO - "repository": "", 14:52:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:52:22 INFO - "buildid": "20160712111957", 14:52:22 INFO - "pgo_build": "False", 14:52:22 INFO - "basedir": "/builds/slave/test", 14:52:22 INFO - "buildnumber": 16, 14:52:22 INFO - "slavename": "t-yosemite-r7-0009", 14:52:22 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 14:52:22 INFO - "platform": "yosemite_r7", 14:52:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:52:22 INFO - "branch": "mozilla-beta", 14:52:22 INFO - "repo_path": "releases/mozilla-beta", 14:52:22 INFO - "revision": "1748a233dae02d02e14bb64d378dc8cc3ae4a1b0", 14:52:22 INFO - "stage_platform": "macosx64", 14:52:22 INFO - "builduid": "7d6176452a1c4b7b8f7d2f9d47b9e21f", 14:52:22 INFO - "slavebuilddir": "test" 14:52:22 INFO - } 14:52:22 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.dmg. 14:52:22 INFO - Running post-action listener: _resource_record_post_action 14:52:22 INFO - ##### 14:52:22 INFO - ##### Running download-and-extract step. 14:52:22 INFO - ##### 14:52:22 INFO - Running pre-action listener: _resource_record_pre_action 14:52:22 INFO - Running main action method: download_and_extract 14:52:22 INFO - mkdir: /builds/slave/test/build/tests 14:52: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')]} 14:52:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.test_packages.json 14:52:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/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 14:52:22 INFO - Downloaded 1165 bytes. 14:52:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:52:22 INFO - Using the following test package requirements: 14:52:22 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:52:22 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:52:22 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 14:52:22 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:52:22 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 14:52:22 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:52:22 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:52:22 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 14:52:22 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:52:22 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:52:22 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 14:52:22 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:52:22 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 14:52:22 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:52:22 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 14:52:22 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:52:22 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 14:52:22 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 14:52: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')]} 14:52:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.common.tests.zip 14:52:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 14:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/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 14:52:23 INFO - Downloaded 18351487 bytes. 14:52: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'] 14:52: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 14:52:26 INFO - Return code: 0 14:52: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 14:52: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')]} 14:52:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.common.tests.zip 14:52:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 14:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/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 14:52:26 INFO - Downloaded 18351487 bytes. 14:52: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'] 14:52: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 14:52:30 INFO - Return code: 0 14:52: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')]} 14:52:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.talos.tests.zip 14:52:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 14:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/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 14:52:30 INFO - Downloaded 10840145 bytes. 14:52: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'] 14:52: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 14:52:30 INFO - Return code: 0 14:52: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')]} 14:52:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.dmg 14:52:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 14:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 14:52:31 INFO - Downloaded 86189689 bytes. 14:52:31 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.dmg 14:52:31 INFO - mkdir: /builds/slave/test/properties 14:52:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:52:31 INFO - Writing to file /builds/slave/test/properties/build_url 14:52:31 INFO - Contents: 14:52:31 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.dmg 14:52:32 INFO - Running post-action listener: _resource_record_post_action 14:52:32 INFO - Running post-action listener: set_extra_try_arguments 14:52:32 INFO - ##### 14:52:32 INFO - ##### Running populate-webroot step. 14:52:32 INFO - ##### 14:52:32 INFO - Running pre-action listener: _resource_record_pre_action 14:52:32 INFO - Running main action method: populate_webroot 14:52:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:52:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:52:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:52:32 INFO - '--tppagecycles', 14:52:32 INFO - '7'], 14:52:32 INFO - 'tests': ['tsvgm']}}, 14:52:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:52:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:52:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:52:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:52:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:52:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:52:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:32 INFO - 'talos_options': ['--disable-e10s'], 14:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:52:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:52:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:32 INFO - 'talos_options': ['--disable-e10s'], 14:52:32 INFO - 'tests': ['damp', 'tps']}, 14:52:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:32 INFO - 'tests': ['damp', 'tps']}, 14:52:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:52:32 INFO - 'tests': ['dromaeo_dom']}, 14:52:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:52:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:52:32 INFO - 'tests': ['a11yr', 14:52:32 INFO - 'ts_paint', 14:52:32 INFO - 'tpaint', 14:52:32 INFO - 'sessionrestore', 14:52:32 INFO - 'sessionrestore_no_auto_restore', 14:52:32 INFO - 'tabpaint']}, 14:52:32 INFO - 'other-e10s': {'tests': ['a11yr', 14:52:32 INFO - 'ts_paint', 14:52:32 INFO - 'tpaint', 14:52:32 INFO - 'sessionrestore', 14:52:32 INFO - 'sessionrestore_no_auto_restore', 14:52:32 INFO - 'tabpaint']}, 14:52:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:52:32 INFO - 'ts_paint', 14:52:32 INFO - 'tpaint', 14:52:32 INFO - 'sessionrestore', 14:52:32 INFO - 'sessionrestore_no_auto_restore', 14:52:32 INFO - 'tabpaint']}, 14:52:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:52:32 INFO - 'ts_paint', 14:52:32 INFO - 'tpaint', 14:52:32 INFO - 'sessionrestore', 14:52:32 INFO - 'sessionrestore_no_auto_restore', 14:52:32 INFO - 'tabpaint']}, 14:52:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:52:32 INFO - 'tests': ['a11yr', 14:52:32 INFO - 'ts_paint', 14:52:32 INFO - 'tpaint', 14:52:32 INFO - 'sessionrestore', 14:52:32 INFO - 'sessionrestore_no_auto_restore', 14:52:32 INFO - 'tabpaint']}, 14:52:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:52:32 INFO - 'tests': ['a11yr', 14:52:32 INFO - 'ts_paint', 14:52:32 INFO - 'tpaint', 14:52:32 INFO - 'sessionrestore', 14:52:32 INFO - 'sessionrestore_no_auto_restore', 14:52:32 INFO - 'tabpaint']}, 14:52:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:52:32 INFO - 'tests': ['tsvgx', 14:52:32 INFO - 'tsvgr_opacity', 14:52:32 INFO - 'tart', 14:52:32 INFO - 'tscrollx', 14:52:32 INFO - 'cart']}, 14:52:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:52:32 INFO - 'tsvgr_opacity', 14:52:32 INFO - 'tart', 14:52:32 INFO - 'tscrollx', 14:52:32 INFO - 'cart']}, 14:52:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:32 INFO - 'talos_options': ['--disable-e10s'], 14:52:32 INFO - 'tests': ['tp5o']}, 14:52:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:32 INFO - 'tests': ['tp5o']}, 14:52:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:32 INFO - 'talos_options': ['--disable-e10s', 14:52:32 INFO - '--xperf_path', 14:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:52:32 INFO - 'tests': ['tp5n']}, 14:52:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:32 INFO - 'talos_options': ['--xperf_path', 14:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:52:32 INFO - 'tests': ['tp5n']}}, 14:52:32 INFO - 'talos.zip': {'path': '', 14:52:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:52:32 INFO - Running post-action listener: _resource_record_post_action 14:52:32 INFO - ##### 14:52:32 INFO - ##### Running create-virtualenv step. 14:52:32 INFO - ##### 14:52:32 INFO - Running pre-action listener: _resource_record_pre_action 14:52:32 INFO - Running main action method: create_virtualenv 14:52:32 INFO - Creating virtualenv /builds/slave/test/build/venv 14:52:32 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 14:52:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:52:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:52:32 INFO - Using real prefix '/tools/python27' 14:52:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:52:33 INFO - Installing distribute.............................................................................................................................................................................................done. 14:52:35 INFO - Installing pip.................done. 14:52:35 INFO - Return code: 0 14:52:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:52:35 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')]} 14:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:35 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')]} 14:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:35 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 0x1092b7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092c7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc710c84910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109156e00>, '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 0x108fbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109151b20>, '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.eaPq3bscuQ/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.7i1zLToSSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:52:35 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 14:52:35 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 14:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eaPq3bscuQ/Render', 14:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:35 INFO - 'HOME': '/Users/cltbld', 14:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:35 INFO - 'LOGNAME': 'cltbld', 14:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:35 INFO - 'MOZ_NO_REMOTE': '1', 14:52:35 INFO - 'NO_EM_RESTART': '1', 14:52:35 INFO - 'PAGER': '/bin/cat', 14:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:35 INFO - 'PWD': '/builds/slave/test', 14:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:35 INFO - 'SHELL': '/bin/bash', 14:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7i1zLToSSA/Listeners', 14:52:35 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:35 INFO - 'USER': 'cltbld', 14:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:35 INFO - 'XPC_FLAGS': '0x0', 14:52:35 INFO - 'XPC_SERVICE_NAME': '0', 14:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:36 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 14:52:36 INFO - Cleaning up... 14:52:36 INFO - Return code: 0 14:52:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1092b7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092c7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc710c84910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109156e00>, '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 0x108fbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109151b20>, '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.eaPq3bscuQ/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.7i1zLToSSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:52:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eaPq3bscuQ/Render', 14:52:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:36 INFO - 'HOME': '/Users/cltbld', 14:52:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:36 INFO - 'LOGNAME': 'cltbld', 14:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:36 INFO - 'MOZ_NO_REMOTE': '1', 14:52:36 INFO - 'NO_EM_RESTART': '1', 14:52:36 INFO - 'PAGER': '/bin/cat', 14:52:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:36 INFO - 'PWD': '/builds/slave/test', 14:52:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:36 INFO - 'SHELL': '/bin/bash', 14:52:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7i1zLToSSA/Listeners', 14:52:36 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:52:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:36 INFO - 'USER': 'cltbld', 14:52:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:36 INFO - 'XPC_FLAGS': '0x0', 14:52:36 INFO - 'XPC_SERVICE_NAME': '0', 14:52:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:36 INFO - Downloading/unpacking psutil>=0.7.1 14:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:52:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:52:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:52:40 INFO - Installing collected packages: psutil 14:52:40 INFO - Running setup.py install for psutil 14:52:40 INFO - building 'psutil._psutil_osx' extension 14:52:40 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 14:52:40 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 14:52:40 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 14:52:40 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 14:52:40 INFO - building 'psutil._psutil_posix' extension 14:52:40 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 14:52:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:52:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:52:40 INFO - ^ 14:52:40 INFO - 1 warning generated. 14:52:40 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 14:52:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:52:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:52:40 INFO - Successfully installed psutil 14:52:40 INFO - Cleaning up... 14:52:41 INFO - Return code: 0 14:52:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:41 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 0x1092b7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092c7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc710c84910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109156e00>, '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 0x108fbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109151b20>, '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.eaPq3bscuQ/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.7i1zLToSSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:52:41 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 14:52:41 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 14:52:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eaPq3bscuQ/Render', 14:52:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:41 INFO - 'HOME': '/Users/cltbld', 14:52:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:41 INFO - 'LOGNAME': 'cltbld', 14:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:41 INFO - 'MOZ_NO_REMOTE': '1', 14:52:41 INFO - 'NO_EM_RESTART': '1', 14:52:41 INFO - 'PAGER': '/bin/cat', 14:52:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:41 INFO - 'PWD': '/builds/slave/test', 14:52:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:41 INFO - 'SHELL': '/bin/bash', 14:52:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7i1zLToSSA/Listeners', 14:52:41 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:52:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:41 INFO - 'USER': 'cltbld', 14:52:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:41 INFO - 'XPC_FLAGS': '0x0', 14:52:41 INFO - 'XPC_SERVICE_NAME': '0', 14:52:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:52:41 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 14:52:41 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 14:52:41 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 14:52:41 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 14:52:41 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 14:52:41 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 14:52:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:52:44 INFO - Installing collected packages: mozsystemmonitor 14:52:44 INFO - Running setup.py install for mozsystemmonitor 14:52:44 INFO - Successfully installed mozsystemmonitor 14:52:44 INFO - Cleaning up... 14:52:44 INFO - Return code: 0 14:52:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:44 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 0x1092b7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092c7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc710c84910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109156e00>, '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 0x108fbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109151b20>, '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.eaPq3bscuQ/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.7i1zLToSSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:52:44 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 14:52:44 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 14:52:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eaPq3bscuQ/Render', 14:52:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:44 INFO - 'HOME': '/Users/cltbld', 14:52:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:44 INFO - 'LOGNAME': 'cltbld', 14:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:44 INFO - 'MOZ_NO_REMOTE': '1', 14:52:44 INFO - 'NO_EM_RESTART': '1', 14:52:44 INFO - 'PAGER': '/bin/cat', 14:52:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:44 INFO - 'PWD': '/builds/slave/test', 14:52:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:44 INFO - 'SHELL': '/bin/bash', 14:52:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7i1zLToSSA/Listeners', 14:52:44 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:52:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:44 INFO - 'USER': 'cltbld', 14:52:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:44 INFO - 'XPC_FLAGS': '0x0', 14:52:44 INFO - 'XPC_SERVICE_NAME': '0', 14:52:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:52:45 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 14:52:45 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 14:52:45 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 14:52:45 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 14:52:45 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 14:52:45 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 14:52:49 INFO - Downloading blobuploader-1.2.4.tar.gz 14:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:52:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:52:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:51 INFO - Downloading docopt-0.6.1.tar.gz 14:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:52:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:52:52 INFO - Running setup.py install for blobuploader 14:52:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:52:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:52:52 INFO - Running setup.py install for requests 14:52:52 INFO - Running setup.py install for docopt 14:52:52 INFO - Successfully installed blobuploader requests docopt 14:52:52 INFO - Cleaning up... 14:52:52 INFO - Return code: 0 14:52:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:52 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 0x1092b7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092c7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc710c84910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109156e00>, '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 0x108fbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109151b20>, '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.eaPq3bscuQ/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.7i1zLToSSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:52:52 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 14:52:52 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 14:52:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eaPq3bscuQ/Render', 14:52:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:52 INFO - 'HOME': '/Users/cltbld', 14:52:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:52 INFO - 'LOGNAME': 'cltbld', 14:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:52 INFO - 'MOZ_NO_REMOTE': '1', 14:52:52 INFO - 'NO_EM_RESTART': '1', 14:52:52 INFO - 'PAGER': '/bin/cat', 14:52:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:52 INFO - 'PWD': '/builds/slave/test', 14:52:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:52 INFO - 'SHELL': '/bin/bash', 14:52:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7i1zLToSSA/Listeners', 14:52:52 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:52:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:52 INFO - 'USER': 'cltbld', 14:52:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:52 INFO - 'XPC_FLAGS': '0x0', 14:52:52 INFO - 'XPC_SERVICE_NAME': '0', 14:52:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:52:53 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-tiN_Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:52:53 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-r5JskC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:52:53 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-nhVmuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:52:53 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-arYxW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:52:53 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-M1l4eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:52:53 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-3ItCzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:52:53 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-nQHnjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:52:53 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-x_sbcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:52:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-mDMiPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:52:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-qkQmcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:52:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-85QNww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:52:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Qy_qdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:52:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-lvXtGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:52:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-8qrdfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-WyVipP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:52:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-fM8pGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:52:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-gWqxIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:52:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:52:54 INFO - Running setup.py install for manifestparser 14:52:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:52:55 INFO - Running setup.py install for mozcrash 14:52:55 INFO - Running setup.py install for mozdebug 14:52:55 INFO - Running setup.py install for mozdevice 14:52:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:52:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:52:55 INFO - Running setup.py install for mozfile 14:52:55 INFO - Running setup.py install for mozhttpd 14:52:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:52:55 INFO - Running setup.py install for mozinfo 14:52:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:52:55 INFO - Running setup.py install for mozInstall 14:52:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:52:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:52:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:52:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:52:56 INFO - Running setup.py install for mozleak 14:52:56 INFO - Running setup.py install for mozlog 14:52:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:52:56 INFO - Running setup.py install for moznetwork 14:52:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:52:56 INFO - Running setup.py install for mozprocess 14:52:56 INFO - Running setup.py install for mozprofile 14:52:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:52:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:52:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:52:56 INFO - Running setup.py install for mozrunner 14:52:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:52:57 INFO - Running setup.py install for mozscreenshot 14:52:57 INFO - Running setup.py install for moztest 14:52:57 INFO - Running setup.py install for mozversion 14:52:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:52:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:52:57 INFO - Cleaning up... 14:52:57 INFO - Return code: 0 14:52:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:57 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 0x1092b7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092c7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc710c84910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109156e00>, '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 0x108fbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109151b20>, '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.eaPq3bscuQ/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.7i1zLToSSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:52:57 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 14:52:57 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 14:52:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eaPq3bscuQ/Render', 14:52:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:57 INFO - 'HOME': '/Users/cltbld', 14:52:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:57 INFO - 'LOGNAME': 'cltbld', 14:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:57 INFO - 'MOZ_NO_REMOTE': '1', 14:52:57 INFO - 'NO_EM_RESTART': '1', 14:52:57 INFO - 'PAGER': '/bin/cat', 14:52:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:57 INFO - 'PWD': '/builds/slave/test', 14:52:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:57 INFO - 'SHELL': '/bin/bash', 14:52:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7i1zLToSSA/Listeners', 14:52:57 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:52:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:57 INFO - 'USER': 'cltbld', 14:52:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:57 INFO - 'XPC_FLAGS': '0x0', 14:52:57 INFO - 'XPC_SERVICE_NAME': '0', 14:52:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:52:57 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ZxDpFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:52:57 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)) 14:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:52:57 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ZbiDDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:52:58 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)) 14:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:52:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-hct0hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:52:58 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)) 14:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:52:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-oJ6_nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:52:58 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)) 14:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:52:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-kQq6Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:52:58 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)) 14:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:52:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-PTWQ0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:52:58 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)) 14:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:52:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-kf0I2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:52:58 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)) 14:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:52:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-GjumQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:52:58 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)) 14:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:52:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ABhY8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:52:58 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)) 14:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:52:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ppeHuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:52:58 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)) 14:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:52:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-_W3np6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:52:58 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)) 14:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:52:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-JS_VPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:52:59 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)) 14:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:52:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-2H0_da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:52:59 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)) 14:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:52:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-95_1WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:52:59 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)) 14:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-mk_wpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:59 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)) 14:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:52:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-SrvR9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:52:59 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)) 14:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:52:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-CvHMWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:52:59 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)) 14:52:59 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)) 14:52:59 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)) 14:52:59 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)) 14:52:59 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)) 14:52:59 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)) 14:52:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:02 INFO - Downloading blessings-1.6.tar.gz 14:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:53:02 INFO - Installing collected packages: blessings 14:53:02 INFO - Running setup.py install for blessings 14:53:02 INFO - Successfully installed blessings 14:53:02 INFO - Cleaning up... 14:53:02 INFO - Return code: 0 14:53:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:53:02 INFO - Reading from file tmpfile_stdout 14:53:02 INFO - Current package versions: 14:53:02 INFO - blessings == 1.6 14:53:02 INFO - blobuploader == 1.2.4 14:53:02 INFO - docopt == 0.6.1 14:53:02 INFO - manifestparser == 1.1 14:53:02 INFO - mozInstall == 1.12 14:53:02 INFO - mozcrash == 0.17 14:53:02 INFO - mozdebug == 0.1 14:53:02 INFO - mozdevice == 0.48 14:53:02 INFO - mozfile == 1.2 14:53:02 INFO - mozhttpd == 0.7 14:53:02 INFO - mozinfo == 0.9 14:53:02 INFO - mozleak == 0.1 14:53:02 INFO - mozlog == 3.1 14:53:02 INFO - moznetwork == 0.27 14:53:02 INFO - mozprocess == 0.22 14:53:02 INFO - mozprofile == 0.28 14:53:02 INFO - mozrunner == 6.11 14:53:02 INFO - mozscreenshot == 0.1 14:53:02 INFO - mozsystemmonitor == 0.0 14:53:02 INFO - moztest == 0.7 14:53:02 INFO - mozversion == 1.4 14:53:02 INFO - psutil == 3.1.1 14:53:02 INFO - requests == 1.2.3 14:53:02 INFO - wsgiref == 0.1.2 14:53:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:02 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')]} 14:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:02 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')]} 14:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:02 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 0x1092b7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092c7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc710c84910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109156e00>, '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 0x108fbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109151b20>, '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.eaPq3bscuQ/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.7i1zLToSSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:53:02 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 14:53:02 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 14:53:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eaPq3bscuQ/Render', 14:53:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:02 INFO - 'HOME': '/Users/cltbld', 14:53:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:02 INFO - 'LOGNAME': 'cltbld', 14:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:02 INFO - 'MOZ_NO_REMOTE': '1', 14:53:02 INFO - 'NO_EM_RESTART': '1', 14:53:02 INFO - 'PAGER': '/bin/cat', 14:53:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:02 INFO - 'PWD': '/builds/slave/test', 14:53:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:02 INFO - 'SHELL': '/bin/bash', 14:53:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7i1zLToSSA/Listeners', 14:53:02 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:53:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:02 INFO - 'USER': 'cltbld', 14:53:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:02 INFO - 'XPC_FLAGS': '0x0', 14:53:02 INFO - 'XPC_SERVICE_NAME': '0', 14:53:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:03 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)) 14:53:03 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)) 14:53:03 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)) 14:53:03 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)) 14:53:03 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)) 14:53:03 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)) 14:53:03 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)) 14:53:03 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)) 14:53:03 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)) 14:53:03 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)) 14:53:03 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)) 14:53:03 INFO - Cleaning up... 14:53:03 INFO - Return code: 0 14:53:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:03 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 0x1092b7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092c7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc710c84910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109156e00>, '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 0x108fbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109151b20>, '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.eaPq3bscuQ/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.7i1zLToSSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:53:03 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 14:53:03 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 14:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eaPq3bscuQ/Render', 14:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:03 INFO - 'HOME': '/Users/cltbld', 14:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:03 INFO - 'LOGNAME': 'cltbld', 14:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:03 INFO - 'MOZ_NO_REMOTE': '1', 14:53:03 INFO - 'NO_EM_RESTART': '1', 14:53:03 INFO - 'PAGER': '/bin/cat', 14:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:03 INFO - 'PWD': '/builds/slave/test', 14:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:03 INFO - 'SHELL': '/bin/bash', 14:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7i1zLToSSA/Listeners', 14:53:03 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:03 INFO - 'USER': 'cltbld', 14:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:03 INFO - 'XPC_FLAGS': '0x0', 14:53:03 INFO - 'XPC_SERVICE_NAME': '0', 14:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:03 INFO - Downloading/unpacking jsonschema 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:53:06 INFO - Downloading/unpacking functools32 (from jsonschema) 14:53:06 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 14:53:06 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 14:53:06 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 14:53:06 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 14:53:06 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 14:53:06 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 14:53:07 INFO - Downloading functools32-3.2.3-2.tar.gz 14:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:53:07 INFO - warning: no files found matching '*.txt' 14:53:07 INFO - no previously-included directories found matching 'build' 14:53:07 INFO - no previously-included directories found matching 'dist' 14:53:07 INFO - no previously-included directories found matching '.git*' 14:53:07 INFO - Installing collected packages: jsonschema, functools32 14:53:07 INFO - Running setup.py install for functools32 14:53:07 INFO - warning: no files found matching '*.txt' 14:53:07 INFO - no previously-included directories found matching 'build' 14:53:07 INFO - no previously-included directories found matching 'dist' 14:53:07 INFO - no previously-included directories found matching '.git*' 14:53:07 INFO - Successfully installed jsonschema functools32 14:53:07 INFO - Cleaning up... 14:53:07 INFO - Return code: 0 14:53:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:53:07 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')]} 14:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:07 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')]} 14:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:07 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 0x1092b7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092c7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc710c84910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109156e00>, '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 0x108fbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109151b20>, '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.eaPq3bscuQ/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.7i1zLToSSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 14:53:07 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 14:53:07 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 14:53:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eaPq3bscuQ/Render', 14:53:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:07 INFO - 'HOME': '/Users/cltbld', 14:53:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:07 INFO - 'LOGNAME': 'cltbld', 14:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:07 INFO - 'MOZ_NO_REMOTE': '1', 14:53:07 INFO - 'NO_EM_RESTART': '1', 14:53:07 INFO - 'PAGER': '/bin/cat', 14:53:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:07 INFO - 'PWD': '/builds/slave/test', 14:53:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:07 INFO - 'SHELL': '/bin/bash', 14:53:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7i1zLToSSA/Listeners', 14:53:07 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:53:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:07 INFO - 'USER': 'cltbld', 14:53:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:07 INFO - 'XPC_FLAGS': '0x0', 14:53:07 INFO - 'XPC_SERVICE_NAME': '0', 14:53:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:07 INFO - Downloading/unpacking flake8 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:53:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:53:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:53:12 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 14:53:12 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 14:53:12 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 14:53:12 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 14:53:12 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 14:53:12 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 14:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:53:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:53:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:53:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:53:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:53:12 INFO - no previously-included directories found matching 'docs/_build' 14:53:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:53:12 INFO - Running setup.py install for pep8 14:53:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:53:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:53:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:53:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:53:12 INFO - no previously-included directories found matching 'docs/_build' 14:53:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:53:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:53:12 INFO - Cleaning up... 14:53:12 INFO - Return code: 0 14:53:12 INFO - Running post-action listener: _resource_record_post_action 14:53:12 INFO - Running post-action listener: _start_resource_monitoring 14:53:12 INFO - Starting resource monitoring. 14:53:12 INFO - ##### 14:53:13 INFO - ##### Running install step. 14:53:13 INFO - ##### 14:53:13 INFO - Running pre-action listener: _resource_record_pre_action 14:53:13 INFO - Running main action method: install 14:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:53:13 INFO - Reading from file tmpfile_stdout 14:53:13 INFO - Detecting whether we're running mozinstall >=1.0... 14:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:53:13 INFO - Reading from file tmpfile_stdout 14:53:13 INFO - Output received: 14:53:13 INFO - Usage: mozinstall [options] installer 14:53:13 INFO - Options: 14:53:13 INFO - -h, --help show this help message and exit 14:53:13 INFO - -d DEST, --destination=DEST 14:53:13 INFO - Directory to install application into. [default: 14:53:13 INFO - "/builds/slave/test"] 14:53:13 INFO - --app=APP Application being installed. [default: firefox] 14:53:13 INFO - mkdir: /builds/slave/test/build/application 14:53:13 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'] 14:53:13 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 14:53:35 INFO - Reading from file tmpfile_stdout 14:53:35 INFO - Output received: 14:53:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:53:35 INFO - Running post-action listener: _resource_record_post_action 14:53:35 INFO - ##### 14:53:35 INFO - ##### Running run-tests step. 14:53:35 INFO - ##### 14:53:35 INFO - Running pre-action listener: _resource_record_pre_action 14:53:35 INFO - Running main action method: run_tests 14:53:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:53:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:53:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:53:35 INFO - 2016-07-15 14:53:35.257 screenresolution[1925:18091] starting screenresolution argv=screenresolution get 14:53:35 INFO - 2016-07-15 14:53:35.260 screenresolution[1925:18091] Display 0: 1600x1200x32@60 14:53:35 INFO - 2016-07-15 14:53:35.266 screenresolution[1926:18094] starting screenresolution argv=screenresolution list 14:53:35 INFO - Available Modes on Display 0 14:53:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:53:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:53:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:53:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:53:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:53:35 INFO - Intel Iris: 14:53:35 INFO - Chipset Model: Intel Iris 14:53:35 INFO - Type: GPU 14:53:35 INFO - Bus: Built-In 14:53:35 INFO - VRAM (Dynamic, Max): 1536 MB 14:53:35 INFO - Vendor: Intel (0x8086) 14:53:35 INFO - Device ID: 0x0a2e 14:53:35 INFO - Revision ID: 0x0009 14:53:35 INFO - Displays: 14:53:35 INFO - Display: 14:53:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:53:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:53:35 INFO - Display Serial Number: 1600x1200 60 14:53:35 INFO - Main Display: Yes 14:53:35 INFO - Mirror: Off 14:53:35 INFO - Online: Yes 14:53:35 INFO - Rotation: Supported 14:53:35 INFO - Return code: 0 14:53:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:53:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:53:35 INFO - Python 2.7.3 14:53:35 INFO - Return code: 0 14:53:35 INFO - grabbing minidump binary from tooltool 14:53:35 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')]} 14:53:35 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 0x109156e00>, '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 0x108fbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109151b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:53:35 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 14:53:35 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 14:53:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:53:35 INFO - Return code: 0 14:53:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:53:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:53:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:53:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:53:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:53:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:53:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:53:36 INFO - Return code: 0 14:53:36 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/1468347597/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 14:53:36 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/1468347597/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0009 --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 14:53:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eaPq3bscuQ/Render', 14:53:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:36 INFO - 'HOME': '/Users/cltbld', 14:53:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:36 INFO - 'LOGNAME': 'cltbld', 14:53:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:53:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:36 INFO - 'MOZ_NO_REMOTE': '1', 14:53:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:53:36 INFO - 'NO_EM_RESTART': '1', 14:53:36 INFO - 'PAGER': '/bin/cat', 14:53:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:36 INFO - 'PWD': '/builds/slave/test', 14:53:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:53:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:36 INFO - 'SHELL': '/bin/bash', 14:53:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7i1zLToSSA/Listeners', 14:53:36 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 14:53:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:36 INFO - 'USER': 'cltbld', 14:53:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:36 INFO - 'XPC_FLAGS': '0x0', 14:53:36 INFO - 'XPC_SERVICE_NAME': '0', 14:53:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:36 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/1468347597/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 14:53:36 INFO - mozversion application_buildid: 20160712111957 14:53:36 INFO - mozversion application_changeset: 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 14:53:36 INFO - mozversion application_display_name: Firefox 14:53:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:53:36 INFO - mozversion application_name: Firefox 14:53:36 INFO - mozversion application_remotingname: firefox 14:53:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:53:36 INFO - mozversion application_vendor: Mozilla 14:53:36 INFO - mozversion application_version: 48.0 14:53:36 INFO - mozversion platform_buildid: 20160712111957 14:53:36 INFO - mozversion platform_changeset: 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 14:53:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:53:36 INFO - mozversion platform_version: 48.0 14:53:36 INFO - using testdate: 1468619616 14:53:36 INFO - actual date: 1468619616 14:53:36 INFO - starting webserver on 'localhost:54491' 14:53:36 INFO - SUITE-START | Running 2 tests 14:53:36 INFO - TEST-START | dromaeo_css 14:53:36 INFO - operating with platform_type : mac_ 14:53:36 INFO - Initialising browser for dromaeo_css test... 14:53:36 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpJ7HwBw/profile http://localhost:54491/getInfo.html) 14:53:39 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 14:53:39 INFO - PROCESS | 1944 | colorDepth:24 14:53:39 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 14:53:39 INFO - PROCESS | 1944 | __metrics 14:53:39 INFO - PROCESS | 1944 | 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" 14:53:39 ERROR - PROCESS | 1944 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:53:39 INFO - TEST-INFO | 1944: exit 0 14:53:39 INFO - Browser initialized. 14:53:39 INFO - Running cycle 1/1 for dromaeo_css test... 14:53:39 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpJ7HwBw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:53:51 INFO - PROCESS | 1947 | RSS: Main: 162287616 14:53:51 INFO - PROCESS | 1947 | 14:54:42 INFO - PROCESS | 1947 | 1468619682914 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] 14:56:52 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54491/tests/dromaeo/cssquery-ext.html) 14:56:54 INFO - PROCESS | 1947 | RSS: Main: 302764032 14:56:54 INFO - PROCESS | 1947 | 14:59:57 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54491/tests/dromaeo/cssquery-ext.html (next: http://localhost:54491/tests/dromaeo/cssquery-jquery.html) 14:59:57 INFO - PROCESS | 1947 | RSS: Main: 308195328 14:59:57 INFO - PROCESS | 1947 | 15:02:59 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54491/tests/dromaeo/cssquery-mootools.html) 15:03:00 INFO - PROCESS | 1947 | RSS: Main: 308727808 15:03:00 INFO - PROCESS | 1947 | 15:06:02 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54491/tests/dromaeo/cssquery-prototype.html) 15:06:02 INFO - PROCESS | 1947 | RSS: Main: 304762880 15:06:02 INFO - PROCESS | 1947 | 15:09:05 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54491/tests/dromaeo/cssquery-yui.html) 15:09:06 INFO - PROCESS | 1947 | RSS: Main: 275247104 15:09:06 INFO - PROCESS | 1947 | 15:12:09 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:54491/tests/dromaeo/cssquery-yui.html (next: http://localhost:54491/tests/dromaeo/cssquery-dojo.html) 15:12:09 INFO - PROCESS | 1947 | RSS: Main: 346423296 15:12:09 INFO - PROCESS | 1947 | 15:12:09 INFO - PROCESS | 1947 | __start_tp_report 15:12:09 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 15:12:09 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 15:12:09 INFO - PROCESS | 1947 | |i|pagename|runs| 15:12:09 INFO - PROCESS | 1947 | |0;dojo.html;3519.9120021999456;3576.856925722972;3580.051286409104;3607.8556857725694;3674.2100448403603;5983.341832398432;6001.729922153502;6023.518118550516;6042.909356359647;6048.6673232972225;5982.641041537511;6043.667598282103;6046.365131661179;6059.636421814695;6071.332153463116;5312.07038768216;5361.410244873061;5433.320834895638;5440.836774896759;5488.423715509874;5418.512333889949;5471.206675032118;5471.206675032118;5475.616706830523;5482.479164479368;5341.332333458317;5414.756335964871;5446.400895901447;5446.754896029668;5464.207689884965;5174.948250517522;5439.646422982493;5480.26016487777;5488.039593071197;5506.834794956158;5314.362276526842;5314.97342513285;5343.625946183769;5399.352077750656;5412.512873841334;5801.419858014207;5810.215620891167;5829;5830.825075247707;5863.7686085922005;6297.527685423612;6321.683915804191;6332.081848132041;6333.303336632966;6335.334789847092;6245.781397651106;6274.968625156891;6332.461740751995;6334.081558174085;6378.394052564999;6077.574569780118;6078.604890682136;6097.939020609826;6104.4200800923845;6107.236595425572;6438.903416448757;6461.773837915651;6465.967670161619;6476.838079048061;6486.935130648728;5083.491650834887;6269.122322874801;6329.936700632935;6363;6371.853066447991;6300.149479820166;6301.275353334334;6304.747810087637;6306.369363063657;6309.08518264849;6277.027060805583;6332.651704156224;6334.778282760081;6349.682515874188;6352.841178970562;6269.811905642747;6340.873182536416;6360.491160707133;6368.29948705642;6379.904301435482;5029.1953287473825;5093.337866077386;5102.4897510248675;5102.872428189251;5125.384953805567;4575.084983003413;4588.541145885451;4589.472210695746;4603.746793926299;4621.861344159681;5838.095095260242;6034.577579569475;6053.969730151321;6071.726772295169;6077.058056001327;6284.968575157186;6294.748210071546;6359.427651511386;6364.522660800459;6373.203349581302;6030.065339872327;6065.484433823174;6077.361877002851;6080.969595151996;6103.298120716175;5474.124140137559;5609.719514024282;5632.831015069554;5635.042042852725;5638.43615638441;6368.299487056513;6463.127477790532;6576.868462630625;6580.8354791130605;6598.175228096488;6315.305316415099;6335.873282534416;6345.238571371465;6349.555531112963;6352.142460767737;6422.3577642235405;6493.74025039012;6506.284308725942;6513.934860651522;6523.575967562093;5249.9737501313775;6270.184875966095;6347.174867267226;6362.618242905441;6366.299707032315;6258.374162583706;6312.021636646327;6339;6345.93654063472;6349.0476428536085;4833.275008748576;6018.548608854441;6337.302896681269;6348.5238607105575;6365.14070600463;5260.631755777059;6269.216347956505;6325.778597749057;6329.556931014785;6335.714892829741;6221.346758590283;6231.40801623845;6265.874682506415;6269.811905642838;6276.811695648955;5270.446603106772;6200;6232.844178895564;6293.874122517433;6295.024271237966;6241.843953901007;6282.277538082996;6294.961331380271;6296.968515157395;6297.338779428094 15:12:09 INFO - PROCESS | 1947 | |1;ext.html;537.1003569021889;542.8572854142031;551.0879494436706;555.3585608622041;567.8353277549511;25512.362190945212;32481.02556923296;32504;32549.349013019724;32625.51061734076;33157.66842331576;33727.494087588646;33737.83131084341;40592.18815623686;41302;9593.856092158623;9782.5597848097;9786.217102631772;9787.021297870227;9805.215582753399;9728.610855565768;9868.851967220462;9869.901300987007;9874.456904870229;9886.50567471627;9197.356185067049;9851.605935762596;12092.395380230997;12375.195612285217;12407.56573519927;11988.040956723442;12116.575919842808;12118.697032574168;12129;12133.27200367972;12083.758324833541;12215.022798176213;12221.205621634654;12224.205426647239;12236.204646697935;41291.1741765163;41731.791341043405;41740.37389439161;41776.58223417757;41816.79091604553;3302.2239773653173;3314.171457135716;3500.43992961125;3836.9424458633143;4153.335466325373;28893;28984;29756.958506452385;30411.087667370015;30838.920637777795;2758.9310267243277;2758.944821103587;2770.1689493152176;2824.1527541737396;2850.2161905475955;504882;507727;508748;509087;509091;37190.07024824347;37364;54568;66565.00152497717;66799;35823.283534329166;35904.461433078526;36015.63984360123;36049.81975090108;36121.45817812735;16081.356745730274;16226.756598651029;16238.269277882524;16241.918790405973;16295.103769292802;13626;13680.863191368158;13692.452301907811;13702.657433564042;13723.931380343034;7223.386012188917;7880.448368614257;8059.5164290142775;8272.296854767412;8421.284190843724;3296.456084746038;3344.3311337732553;3350.715189208896;3419.3845107880325;3549.432090865501;996.5415908681942;1011.0193112680688;1055.8574592429923;1131.6095946898306;1135.9318440893574;29930.102096937127;30050.699493005228;30088.699113008588;30378.392432151675;30650.38699226003;1024.6618615856748;1089.1722291058852;1095.5289225632896;1138.869030061537;1153.6250718516517;12497.437615307334;12742.80885786714;15300.234988250542;15486.5354039379;15773.526794195963;639063;643289;643620;644353;644500;62990.68504657447;63942.040869387;63991.36008639854;64006.6799666008;64160.71678566402;1409.2319685771279;1505.3903169216267;1549.124744519343;1560.2978659603225;1570.6309017380906;24495.75504245006;29288.560671589516;29933.55099673463;29961.70038299676;30649;49152;49452;49455.7527212376;49472.50527494823;49985.00029999452;352730;354831;355269;607310;649151;27286.863565682044;27413;27866.303342416602;27879.442411151256;27919.302017449725;45698.77150614226;48389;48576;48656;48946;36957.63042369542;37703.24593508169;37733.05667358228;37821.62178378291;38608;33136.834315828266;38954.80522597369;39029.2194156121;39205.60794392019;39711.40432893567;39355.6064439352;39721.60278397179;39913.2017359657;39951.40072898967;40025.399619005155;27147.72852271452;27268;33627;34027.65972340245;34079.82960085184;25211.74788252094;25433.491330173663;25511;25870.223893283233;26032.958681652523 15:12:09 INFO - PROCESS | 1947 | |2;jquery.html;415.2338934665542;417.42603919610497;417.60327688695764;417.7911044477761;428.13089428460216;21130.260440884555;21131;21214.257500987467;21860.781392186072;21869.68781873087;17504.64990700185;21913.013914373852;22687.886560567214;22710.659340109913;22723.659145112837;5655.519280861122;6216.191895053659;6229.626222426669;6235.781747638834;6251.562390632657;6041.154238406627;6061.333253342129;6202.565820392574;6208.689565521729;6216;6052.939470605282;6145.815625531219;6191;6193.380661933793;6196.225471816023;5728.455796699307;6169.969150154243;6174.413430724074;6179.536534759888;6182.907256391158;5881.588288819784;5882.088276317178;5885.4997325227405;5888.97055514724;5898;15384.461543845911;26280;26623.46753064928;26661.733382666313;26687.466250675072;1898.4968983219458;2055.597985334259;2222.344408399526;2242.9102835886547;2771.2656146121294;10079.49602519871;11313.264637798517;13719.725605487934;15194.392224311014;15883.920580397024;1809.8552115830835;1836.2287839107607;1888.424030670645;1894.2991093295432;1910.9140088696042;105708;114794;117141;117194;118425.81574184234;11834.644960651194;11964.042876569854;12042.518299267931;12098.758024839453;12115.697107572381;15942.36230550765;15961.36154553828;16005.199740012953;16020;16022.919885400499;9006.909930900738;9313.580888860017;9406.811863762823;9446.197073248852;9476.336656434121;7548.622568871535;9464.337496375188;9476.857847132298;9488.715338539854;9599.856002159973;4805.495422980606;4827.95172048275;4841.975790121097;4859.465458799529;4895.143349913751;1717.5620216844625;1989.3335732529765;2058.989705051465;2083.1875568528285;2083.645780217367;895.6730793260413;987.7283746969497;1011.4588695048261;1033.266380869576;1057.4025675493322;20138;21036.368908932756;21265.255716050175;21910.561788764135;22038.44903877416;959.1271942532262;965.6764983730529;976.3019441099648;979.1432496565506;1005.648023191877;8581.95709021451;11424.714382140513;11670.649880503599;11702.473388697528;11764.764704705858;660960;662663;673510;677111;678636;132926;137963.31018344843;138653.61346386408;139035;142437;890.496869268861;1010.4796030044533;1018.1447584029303;1028.5063169678747;1032.488917985587;18728.344507942158;18896.811031889505;19303.8069619302;20076.19695212175;20199.79800202038;39266.80366598149;48784.51215487799;50241;53351;55075.724621376634;64804.35195647983;73350.89973650292;74686;75920;76383.23616763762;8481.15188481147;8594.35542334315;8620.267277281502;8889.4666320021;9140.588673509576;7420.109586849612;11009.61466348674;12088.939555302168;13199.152118703581;13551.98360122975;11735.647930562096;11861.288322700666;11955;12045.457954391899;12073.939630301793;9791.873934497624;11613.361265130161;11775.705607359541;11811.50732707811;11908.225965312227;9927.553260103457;11842;11928.522859085539;11988;12018.819717704417;8445.66217351299;8564;8896.154865287788;8989.505577193317;9111.544422778967;10723.410212438392;11000.614978475714;11226.607068752555;11266.774664506827;11424.485898134437 15:12:09 INFO - PROCESS | 1947 | |3;mootools.html;1489.8063251777266;1612.2986500872119;1632.5428879913625;1896.3647178195304;2011.9396418107463;7529.774106776792;8262.958685206573;8825.735227943163;8987.820243595132;8992.415492992966;8705.782355441117;8931.41945773526;8943.41867778594;8944.731658050268;8957.596908139132;2519.962200566993;2541.2376287113884;2547.6688030556;2552.5660637691635;2553.221267513408;2468.8518688878635;2535.657686212365;2539.7460253974546;2541.136013755323;2556.8593727344987;2122.5330427306044;2517.748225177486;2546.8726563671835;2560.28312072619;2571.7299683533242;2516.3960649444093;2550.795936325099;2561.5389229938605;2562.7309132541;2563.6410902473667;2506.0477018732763;2538.5430622487943;2549.375403026252;2549.974500254992;2564.551203539373;8847.513386763725;9042.095790420972;9104.044075372056;9149.77125571866;9167.991520932692;5639.830805075854;5835.824925252249;5837.941620583825;5852.619579727347;5853.209816674737;3187.474066778979;3662.7436079474446;3749.512563366772;3797.2215695782297;3800.3919372900205;1040.3705758016442;1068.8610480637467;1070.5985255529176;1086.3536195963388;1110.5335758981248;12384.938075309567;12639.241645501208;12641.36793160329;12659.683507912283;12673.619791406272;4802.783874725646;4845.176320025604;4860.756962151878;4879.219324907997;4888.95111048885;9652.27607929394;9671.419714817133;9678.128968392879;9678.225741940629;9678.75803104928;5610.186522954149;5647.745851436695;5652.378238393773;5660;5660.830175094754;4610.331501932201;4778.235482322882;5080.898382032413;5204.739763011834;5244.423113457517;3986.80065996699;4001.139754952641;4077.898052548651;4105.733127346773;4118.361653943643;1263.696712788924;1267.163671976491;1269.9809502857465;1279.4690203565601;1279.9232046077266;945.0785484153033;967.4678926590487;975.3708857786829;984.7193549838262;1011.8735158105237;6083.270007599116;6163.599366041193;6210.4100110489435;6289.842753931097;6331.96834015827;468.64148926071584;482.36568911881466;490.4923404276557;498.12081675842165;499.88752530681035;3965.20695860829;4053.6959728020515;4089.6728261739586;4122.216778812016;4150.91698166035;11154.386508741934;11603.883961160449;11645.184837061324;11694.2983420995;11723.472443740053;10572;11229;11359.829602555968;11391.259568128045;11412.942935285271;8601.956990215134;8631.352648551383;8672.913270867211;8763.123687631314;8769.736907892773;5065.45503621399;5940.227770389822;5944.613600115978;6195.132681424514;6196.783112591038;9955.900440995498;9998.60005599797;10158.492075396349;10162.136218421518;10177.033181847713;9966.551505182138;10378.117859981987;10451.320664156805;10875.075618572193;10903.890961090288;7098.077249957472;7274.236205198378;7587.848243035219;7929.127795942326;8039.638216280398;8586.184312490303;8598.097199793932;8658.134186581292;8658.913410866062;8694.30445564366;7480.251974802476;7500.212477689764;7561.6597253122645;7676.80807979805;7697.461177717506;7414.295641914009;7442.516236444614;7455.0681164854395;7530.887036694564;7584.924150758642;7186;7308.342249197598;7329.560226386434;7331.926680733124;7343.522671026366;4970.776315065903;4993.950060499348;5120.846374608767;5152.742362881916;5185.896282074413;5039.143345631325;5074.923876141787;5086.872828179326;5186.273921651047;5319.015982043335 15:12:09 INFO - PROCESS | 1947 | |4;prototype.html;332.4398388715015;337.2714935738803;341.1352222116933;345.5939271356156;348.68444058127403;6713.462922966163;6732.2931092235285;6760.966195169023;6790;6809.489288303373;6705.094812200351;6706.39642432181;6711.798646040615;6741.797746067626;6745.426638735713;4747.074320507502;4859.829905953292;4865.708057516543;4954.355933728611;5008.048470790556;4945.332380128691;5006.424261209971;5014.749262536877;5022.0709168803705;5044.545990860822;4968.229924361712;4971.428285747131;4974.87562810929;4980.377452818398;4993.900121997558;4031.2743706132883;4797.280407938802;4832.492588278233;4898.5591296783105;4924.876878078041;4203.55862634422;4221.155768846213;4230.17511585241;4233.767142807144;4235.957640423618;5032.446430892599;6315.305316415191;6319.210098737658;6376.521760867907;6391.712372943229;4846.29728689338;5751.76337087524;5855.76576936922;5862.977272840906;5867.823965281048;6858.8215896997945;7096.787096387065;7097.325754053409;7099.964500177518;7103.502754807166;4751.049790042005;4799.992001679651;4809.807607695688;4810.35060266863;4810.903781924342;5923.970380148072;5985.850353741192;7531.397488200931;7541.472096953215;7579.355754760852;4861.611071114302;4881.389826271716;4886.047220791983;4888.780004899788;4899.363082799213;4959.70241785494;4962.528559786887;4966.6771659842;4971.602271818246;4982.476839931827;5094.497123348621;5487.38122253928;5889.676067816311;5891.3224979127945;5892.6759028253855;6250.718717657716;6844.349786770249;7079.221285658574;7177.856442871113;7200.1359836818865;1416.504223521759;1704.9829501705071;1720.5010546941246;1739.3129713762992;1740.5387572293353;1037.3516552154904;1049.4070849969742;1094.392612100276;1104.629948967089;1123.039800970175;6614.470842332602;6769.966150169218;6812.284710105467;6823.215330237086;6830.385265326145;7580.772576822704;7593.734219302409;7604.8479030419085;7608.923910760932;7611.2769286917655;6782.559133656297;6791.66041697923;6795.626240556718;6799.5920244785475;6824.829379265558;3799.0502374406396;3957.56466788653;3985;3988.4017397390626;3996.760194388346;7777.300042996158;7797.259260370256;7806.531608103532;7810.297073263434;7877.369810415267;6586.407223349922;7525.661345239478;7757.3794096473275;7783.649735761905;7835.804104897309;7854.685812567547;7868.291853733192;7870.724524641724;7879.054513458307;7883.2905038546805;7230.674619642024;7510.211427800221;7514.436417268836;7535.962320188364;7546.396288297033;7351.632418378953;7380.926190738239;7381.630918453949;7400.629968501661;7405.44459165554;6378.74485020594;7382.003429537159;7874.21257874208;7884.329831964347;7895.7236496722335;4075.3071977764444;4687.9765601171775;4700.741459219776;4706.764661766966;4711.057788442256;7225.530340527849;7453.844654078626;7482.2517748224745;7487.401007919245;7499.325060744559;7202.279772022755;7210;7235;7245.710171593078;7252.854942901218;7211.810051341679;7214.2785721427435;7231.566106033655;7258;7276.672549735381;7049.577025378494;7055.259197784364;7072.611006394698;7093.680784364613;7098.964505177441;7037.085178926707;7119;7171.3545780877885;7212.206657267591;7214.74748383804;6798.694058767466;6871.175458944958;6994.475414344046;6996.6151861648095;7011.3339232772805 15:12:09 INFO - PROCESS | 1947 | |5;yui.html;667.8263651450627;715.9928400715993;780.3562061299426;785.2461636828641;795.4193438789683;15347.3093710783;15717.13555754433;15731.370745170208;15739.84260157398;15744.212789360528;14236.501722439716;14487.637809054779;14488.637784055378;14490.5652830415;14497.710045799078;764.3579393309604;782.5304817109745;786.4180506425262;787.0476723164977;787.3189690917344;771.9382449404034;953.2612225525204;956.2588993530001;957.4638202606562;958.2142643032716;995.4922989275449;1005.4972513743129;1007.5163921317771;1007.7480629842539;1008.485672307125;811.5577010529275;997.4514017290497;1000.8398656215044;1001.7345403468087;1002.0780881588955;731.1445608637906;758.981025474362;759.7758661194961;763.3206446262775;763.385474692872;15216.619584510365;15238.695226095417;15259.465918692904;15271.312790924323;15295.770563441558;12927.87072129276;12952.352382380843;13250.867491325156;13333.133451263704;13367.398467069006;10383.169346452265;10456.215783816167;10598.470076496144;10818.945905270502;10898.237123401364;3068.5704001439817;3609.903044328278;3628.2562074774874;3701.777893326382;3858.131920317934;77886.22113778847;78434.60782696107;78530.21469785286;78543.60728196379;79772;8426.199511046441;9068.773280667903;9506.714798556055;9562.713118606453;9599.520023998772;21747.565048698936;21756;21797.67303490449;21814.236501722364;21841.235556755437;6837.042814006043;7527.134379546313;7631.809204769926;7700.268474494914;7843.254890785366;4252;4303.548127446636;4333.414988976448;4388.188185185751;4457.866264012085;3690.741648084662;3738.7569807962395;3743.2513497300647;3746.5316835395574;3764.5294338207723;672.4519516594058;688.5421194905332;701.3617607976716;714.085969958454;723.2947875821137;596.955228357875;613.7943788830792;622.9781957631461;629.5058379172327;630.4011189370117;7724.691012359555;8162.020557533134;8264.710735124241;8343.874841877378;8544.957275213585;593.9109133629904;596.5078809981783;613.7268915332724;623.0094846963997;642.4795915308522;3796.4495148203355;3829.7893615851394;3855.151866589346;3886.805659717003;3944.2900277950243;79026;85414.57292713497;86798.56600716956;87149;87705.68441473383;75490.62254688801;76404;76637.6168119167;76675;78147;68552.6572367135;68600.6569967157;68625.65687171533;68979.62040759157;70216.64891675509;7851.764447066597;7881.620716374497;8485.95757021211;8487.618057187565;8593.484390936565;48482.51517484921;49152.50847491479;49194.75402622964;49517.752411237714;49857.75071124621;67125.62994960489;67263.66368168128;67877.3212267871;68421.23683197272;68999.3100068993;10994.615188468366;11066.948639879198;11294.096472282363;11477.909598588121;11562.88437115618;11883.405829708307;12166.209196402206;12204.938975305422;12404.875951240372;12616.810747838974;11707.121965852766;11723;11742.297366881925;11782.99844513226;11794.941025294818;11486.885131148581;11565.537378504765;11649;11667.824982625438;11959.581414650445;10852.459504083085;10968.957948994832;11138;11570.247933884271;11662.12534059932;7792.454528182972;9486.418079996734;9730.659426920023;9851;9950.253730970062;9429.905700942903;9680.080392362714;9736.464494452874;9779.85330220033;9802.509874506104 15:12:09 INFO - PROCESS | 1947 | __end_tp_report 15:12:09 INFO - PROCESS | 1947 | __start_cc_report 15:12:09 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,1305 15:12:09 INFO - PROCESS | 1947 | __end_cc_report 15:12:09 INFO - PROCESS | 1947 | __startTimestamp1468620729418__endTimestamp 15:12:09 INFO - PROCESS | 1947 | 15:12:09 INFO - PROCESS | 1947 | ------- Summary: start ------- 15:12:09 INFO - PROCESS | 1947 | Number of tests: 6 15:12:09 INFO - PROCESS | 1947 | 15:12:09 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5908.49 Median:6221.35 stddev:634.28 (10.2%) stddev-sans-first:607.92 15:12:09 INFO - PROCESS | 1947 | Values: 3519.9 3576.9 3580.1 3607.9 3674.2 5983.3 6001.7 6023.5 6042.9 6048.7 5982.6 6043.7 6046.4 6059.6 6071.3 5312.1 5361.4 5433.3 5440.8 5488.4 5418.5 5471.2 5471.2 5475.6 5482.5 5341.3 5414.8 5446.4 5446.8 5464.2 5174.9 5439.6 5480.3 5488.0 5506.8 5314.4 5315.0 5343.6 5399.4 5412.5 5801.4 5810.2 5829.0 5830.8 5863.8 6297.5 6321.7 6332.1 6333.3 6335.3 6245.8 6275.0 6332.5 6334.1 6378.4 6077.6 6078.6 6097.9 6104.4 6107.2 6438.9 6461.8 6466.0 6476.8 6486.9 5083.5 6269.1 6329.9 6363.0 6371.9 6300.1 6301.3 6304.7 6306.4 6309.1 6277.0 6332.7 6334.8 6349.7 6352.8 6269.8 6340.9 6360.5 6368.3 6379.9 5029.2 5093.3 5102.5 5102.9 5125.4 4575.1 4588.5 4589.5 4603.7 4621.9 5838.1 6034.6 6054.0 6071.7 6077.1 6285.0 6294.7 6359.4 6364.5 6373.2 6030.1 6065.5 6077.4 6081.0 6103.3 5474.1 5609.7 5632.8 5635.0 5638.4 6368.3 6463.1 6576.9 6580.8 6598.2 6315.3 6335.9 6345.2 6349.6 6352.1 6422.4 6493.7 6506.3 6513.9 6523.6 5250.0 6270.2 6347.2 6362.6 6366.3 6258.4 6312.0 6339.0 6345.9 6349.0 4833.3 6018.5 6337.3 6348.5 6365.1 5260.6 6269.2 6325.8 6329.6 6335.7 6221.3 6231.4 6265.9 6269.8 6276.8 5270.4 6200.0 6232.8 6293.9 6295.0 6241.8 6282.3 6295.0 6297.0 6297.3 15:12:09 INFO - PROCESS | 1947 | 15:12:09 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:66227.43 Median:18749.61 stddev:147116.94 (784.6%) stddev-sans-first:147446.97 15:12:09 INFO - PROCESS | 1947 | Values: 537.1 542.9 551.1 555.4 567.8 25512.4 32481.0 32504.0 32549.3 32625.5 33157.7 33727.5 33737.8 40592.2 41302.0 9593.9 9782.6 9786.2 9787.0 9805.2 9728.6 9868.9 9869.9 9874.5 9886.5 9197.4 9851.6 12092.4 12375.2 12407.6 11988.0 12116.6 12118.7 12129.0 12133.3 12083.8 12215.0 12221.2 12224.2 12236.2 41291.2 41731.8 41740.4 41776.6 41816.8 3302.2 3314.2 3500.4 3836.9 4153.3 28893.0 28984.0 29757.0 30411.1 30838.9 2758.9 2758.9 2770.2 2824.2 2850.2 504882.0 507727.0 508748.0 509087.0 509091.0 37190.1 37364.0 54568.0 66565.0 66799.0 35823.3 35904.5 36015.6 36049.8 36121.5 16081.4 16226.8 16238.3 16241.9 16295.1 13626.0 13680.9 13692.5 13702.7 13723.9 7223.4 7880.4 8059.5 8272.3 8421.3 3296.5 3344.3 3350.7 3419.4 3549.4 996.5 1011.0 1055.9 1131.6 1135.9 29930.1 30050.7 30088.7 30378.4 30650.4 1024.7 1089.2 1095.5 1138.9 1153.6 12497.4 12742.8 15300.2 15486.5 15773.5 639063.0 643289.0 643620.0 644353.0 644500.0 62990.7 63942.0 63991.4 64006.7 64160.7 1409.2 1505.4 1549.1 1560.3 1570.6 24495.8 29288.6 29933.6 29961.7 30649.0 49152.0 49452.0 49455.8 49472.5 49985.0 352730.0 354831.0 355269.0 607310.0 649151.0 27286.9 27413.0 27866.3 27879.4 27919.3 45698.8 48389.0 48576.0 48656.0 48946.0 36957.6 37703.2 37733.1 37821.6 38608.0 33136.8 38954.8 39029.2 39205.6 39711.4 39355.6 39721.6 39913.2 39951.4 40025.4 27147.7 27268.0 33627.0 34027.7 34079.8 25211.7 25433.5 25511.0 25870.2 26033.0 15:12:09 INFO - PROCESS | 1947 | 15:12:09 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:37339.45 Median:12465.40 stddev:111354.65 (893.3%) stddev-sans-first:111632.51 15:12:09 INFO - PROCESS | 1947 | Values: 415.2 417.4 417.6 417.8 428.1 21130.3 21131.0 21214.3 21860.8 21869.7 17504.6 21913.0 22687.9 22710.7 22723.7 5655.5 6216.2 6229.6 6235.8 6251.6 6041.2 6061.3 6202.6 6208.7 6216.0 6052.9 6145.8 6191.0 6193.4 6196.2 5728.5 6170.0 6174.4 6179.5 6182.9 5881.6 5882.1 5885.5 5889.0 5898.0 15384.5 26280.0 26623.5 26661.7 26687.5 1898.5 2055.6 2222.3 2242.9 2771.3 10079.5 11313.3 13719.7 15194.4 15883.9 1809.9 1836.2 1888.4 1894.3 1910.9 105708.0 114794.0 117141.0 117194.0 118425.8 11834.6 11964.0 12042.5 12098.8 12115.7 15942.4 15961.4 16005.2 16020.0 16022.9 9006.9 9313.6 9406.8 9446.2 9476.3 7548.6 9464.3 9476.9 9488.7 9599.9 4805.5 4828.0 4842.0 4859.5 4895.1 1717.6 1989.3 2059.0 2083.2 2083.6 895.7 987.7 1011.5 1033.3 1057.4 20138.0 21036.4 21265.3 21910.6 22038.4 959.1 965.7 976.3 979.1 1005.6 8582.0 11424.7 11670.6 11702.5 11764.8 660960.0 662663.0 673510.0 677111.0 678636.0 132926.0 137963.3 138653.6 139035.0 142437.0 890.5 1010.5 1018.1 1028.5 1032.5 18728.3 18896.8 19303.8 20076.2 20199.8 39266.8 48784.5 50241.0 53351.0 55075.7 64804.4 73350.9 74686.0 75920.0 76383.2 8481.2 8594.4 8620.3 8889.5 9140.6 7420.1 11009.6 12088.9 13199.2 13552.0 11735.6 11861.3 11955.0 12045.5 12073.9 9791.9 11613.4 11775.7 11811.5 11908.2 9927.6 11842.0 11928.5 11988.0 12018.8 8445.7 8564.0 8896.2 8989.5 9111.5 10723.4 11000.6 11226.6 11266.8 11424.5 15:12:09 INFO - PROCESS | 1947 | 15:12:09 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5914.90 Median:2746.92 stddev:3335.28 (121.4%) stddev-sans-first:3328.06 15:12:09 INFO - PROCESS | 1947 | Values: 1489.8 1612.3 1632.5 1896.4 2011.9 7529.8 8263.0 8825.7 8987.8 8992.4 8705.8 8931.4 8943.4 8944.7 8957.6 2520.0 2541.2 2547.7 2552.6 2553.2 2468.9 2535.7 2539.7 2541.1 2556.9 2122.5 2517.7 2546.9 2560.3 2571.7 2516.4 2550.8 2561.5 2562.7 2563.6 2506.0 2538.5 2549.4 2550.0 2564.6 8847.5 9042.1 9104.0 9149.8 9168.0 5639.8 5835.8 5837.9 5852.6 5853.2 3187.5 3662.7 3749.5 3797.2 3800.4 1040.4 1068.9 1070.6 1086.4 1110.5 12384.9 12639.2 12641.4 12659.7 12673.6 4802.8 4845.2 4860.8 4879.2 4889.0 9652.3 9671.4 9678.1 9678.2 9678.8 5610.2 5647.7 5652.4 5660.0 5660.8 4610.3 4778.2 5080.9 5204.7 5244.4 3986.8 4001.1 4077.9 4105.7 4118.4 1263.7 1267.2 1270.0 1279.5 1279.9 945.1 967.5 975.4 984.7 1011.9 6083.3 6163.6 6210.4 6289.8 6332.0 468.6 482.4 490.5 498.1 499.9 3965.2 4053.7 4089.7 4122.2 4150.9 11154.4 11603.9 11645.2 11694.3 11723.5 10572.0 11229.0 11359.8 11391.3 11412.9 8602.0 8631.4 8672.9 8763.1 8769.7 5065.5 5940.2 5944.6 6195.1 6196.8 9955.9 9998.6 10158.5 10162.1 10177.0 9966.6 10378.1 10451.3 10875.1 10903.9 7098.1 7274.2 7587.8 7929.1 8039.6 8586.2 8598.1 8658.1 8658.9 8694.3 7480.3 7500.2 7561.7 7676.8 7697.5 7414.3 7442.5 7455.1 7530.9 7584.9 7186.0 7308.3 7329.6 7331.9 7343.5 4970.8 4994.0 5120.8 5152.7 5185.9 5039.1 5074.9 5086.9 5186.3 5319.0 15:12:09 INFO - PROCESS | 1947 | 15:12:09 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:5875.72 Median:6737.05 stddev:1878.62 (27.9%) stddev-sans-first:1837.24 15:12:09 INFO - PROCESS | 1947 | Values: 332.4 337.3 341.1 345.6 348.7 6713.5 6732.3 6761.0 6790.0 6809.5 6705.1 6706.4 6711.8 6741.8 6745.4 4747.1 4859.8 4865.7 4954.4 5008.0 4945.3 5006.4 5014.7 5022.1 5044.5 4968.2 4971.4 4974.9 4980.4 4993.9 4031.3 4797.3 4832.5 4898.6 4924.9 4203.6 4221.2 4230.2 4233.8 4236.0 5032.4 6315.3 6319.2 6376.5 6391.7 4846.3 5751.8 5855.8 5863.0 5867.8 6858.8 7096.8 7097.3 7100.0 7103.5 4751.0 4800.0 4809.8 4810.4 4810.9 5924.0 5985.9 7531.4 7541.5 7579.4 4861.6 4881.4 4886.0 4888.8 4899.4 4959.7 4962.5 4966.7 4971.6 4982.5 5094.5 5487.4 5889.7 5891.3 5892.7 6250.7 6844.3 7079.2 7177.9 7200.1 1416.5 1705.0 1720.5 1739.3 1740.5 1037.4 1049.4 1094.4 1104.6 1123.0 6614.5 6770.0 6812.3 6823.2 6830.4 7580.8 7593.7 7604.8 7608.9 7611.3 6782.6 6791.7 6795.6 6799.6 6824.8 3799.1 3957.6 3985.0 3988.4 3996.8 7777.3 7797.3 7806.5 7810.3 7877.4 6586.4 7525.7 7757.4 7783.6 7835.8 7854.7 7868.3 7870.7 7879.1 7883.3 7230.7 7510.2 7514.4 7536.0 7546.4 7351.6 7380.9 7381.6 7400.6 7405.4 6378.7 7382.0 7874.2 7884.3 7895.7 4075.3 4688.0 4700.7 4706.8 4711.1 7225.5 7453.8 7482.3 7487.4 7499.3 7202.3 7210.0 7235.0 7245.7 7252.9 7211.8 7214.3 7231.6 7258.0 7276.7 7049.6 7055.3 7072.6 7093.7 7099.0 7037.1 7119.0 7171.4 7212.2 7214.7 6798.7 6871.2 6994.5 6996.6 7011.3 15:12:09 INFO - PROCESS | 1947 | 15:12:09 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:18075.23 Median:613.76 stddev:24804.89 (4041.5%) stddev-sans-first:24840.03 15:12:09 INFO - PROCESS | 1947 | Values: 667.8 716.0 780.4 785.2 795.4 15347.3 15717.1 15731.4 15739.8 15744.2 14236.5 14487.6 14488.6 14490.6 14497.7 764.4 782.5 786.4 787.0 787.3 771.9 953.3 956.3 957.5 958.2 995.5 1005.5 1007.5 1007.7 1008.5 811.6 997.5 1000.8 1001.7 1002.1 731.1 759.0 759.8 763.3 763.4 15216.6 15238.7 15259.5 15271.3 15295.8 12927.9 12952.4 13250.9 13333.1 13367.4 10383.2 10456.2 10598.5 10818.9 10898.2 3068.6 3609.9 3628.3 3701.8 3858.1 77886.2 78434.6 78530.2 78543.6 79772.0 8426.2 9068.8 9506.7 9562.7 9599.5 21747.6 21756.0 21797.7 21814.2 21841.2 6837.0 7527.1 7631.8 7700.3 7843.3 4252.0 4303.5 4333.4 4388.2 4457.9 3690.7 3738.8 3743.3 3746.5 3764.5 672.5 688.5 701.4 714.1 723.3 597.0 613.8 623.0 629.5 630.4 7724.7 8162.0 8264.7 8343.9 8545.0 593.9 596.5 613.7 623.0 642.5 3796.4 3829.8 3855.2 3886.8 3944.3 79026.0 85414.6 86798.6 87149.0 87705.7 75490.6 76404.0 76637.6 76675.0 78147.0 68552.7 68600.7 68625.7 68979.6 70216.6 7851.8 7881.6 8486.0 8487.6 8593.5 48482.5 49152.5 49194.8 49517.8 49857.8 67125.6 67263.7 67877.3 68421.2 68999.3 10994.6 11066.9 11294.1 11477.9 11562.9 11883.4 12166.2 12204.9 12404.9 12616.8 11707.1 11723.0 11742.3 11783.0 11794.9 11486.9 11565.5 11649.0 11667.8 11959.6 10852.5 10969.0 11138.0 11570.2 11662.1 7792.5 9486.4 9730.7 9851.0 9950.3 9429.9 9680.1 9736.5 9779.9 9802.5 15:12:09 INFO - PROCESS | 1947 | -------- Summary: end -------- 15:12:09 INFO - PROCESS | 1947 | 15:12:09 INFO - TEST-INFO | 1947: exit 0 15:12:09 INFO - TEST-OK | dromaeo_css | took 1113063ms 15:12:09 INFO - TEST-START | kraken 15:12:09 INFO - operating with platform_type : mac_ 15:12:09 INFO - Initialising browser for kraken test... 15:12:09 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpissllt/profile http://localhost:54491/getInfo.html) 15:12:12 INFO - PROCESS | 1951 | __metrics Screen width/height:1600/1200 15:12:12 INFO - PROCESS | 1951 | colorDepth:24 15:12:12 INFO - PROCESS | 1951 | Browser inner width/height: 1024/689 15:12:12 INFO - PROCESS | 1951 | __metrics 15:12:12 INFO - PROCESS | 1951 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:12:12 ERROR - PROCESS | 1951 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:12:12 INFO - TEST-INFO | 1951: exit 0 15:12:12 INFO - Browser initialized. 15:12:12 INFO - Running cycle 1/1 for kraken test... 15:12:12 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpissllt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:12:24 INFO - PROCESS | 1954 | RSS: Main: 162316288 15:12:24 INFO - PROCESS | 1954 | 15:12:27 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54491/tests/kraken/driver.html?testName=audio-beat-detection) 15:12:28 INFO - PROCESS | 1954 | RSS: Main: 224493568 15:12:28 INFO - PROCESS | 1954 | 15:12:30 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54491/tests/kraken/driver.html?testName=audio-dft) 15:12:31 INFO - PROCESS | 1954 | RSS: Main: 240250880 15:12:31 INFO - PROCESS | 1954 | 15:12:34 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54491/tests/kraken/driver.html?testName=audio-fft) 15:12:35 INFO - PROCESS | 1954 | RSS: Main: 325603328 15:12:35 INFO - PROCESS | 1954 | 15:12:37 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54491/tests/kraken/driver.html?testName=audio-oscillator) 15:12:37 INFO - PROCESS | 1954 | RSS: Main: 232194048 15:12:37 INFO - PROCESS | 1954 | 15:12:40 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:12:40 INFO - PROCESS | 1954 | RSS: Main: 232796160 15:12:40 INFO - PROCESS | 1954 | 15:12:43 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54491/tests/kraken/driver.html?testName=imaging-darkroom) 15:12:43 INFO - PROCESS | 1954 | RSS: Main: 269582336 15:12:43 INFO - PROCESS | 1954 | 15:12:46 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54491/tests/kraken/driver.html?testName=imaging-desaturate) 15:12:47 INFO - PROCESS | 1954 | RSS: Main: 272809984 15:12:47 INFO - PROCESS | 1954 | 15:12:50 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54491/tests/kraken/driver.html?testName=json-parse-financial) 15:12:50 INFO - PROCESS | 1954 | RSS: Main: 271351808 15:12:50 INFO - PROCESS | 1954 | 15:12:52 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:12:53 INFO - PROCESS | 1954 | RSS: Main: 261369856 15:12:53 INFO - PROCESS | 1954 | 15:12:54 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54491/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:12:55 INFO - PROCESS | 1954 | RSS: Main: 268304384 15:12:55 INFO - PROCESS | 1954 | 15:12:57 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:12:58 INFO - PROCESS | 1954 | RSS: Main: 271618048 15:12:58 INFO - PROCESS | 1954 | 15:13:00 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:13:01 INFO - PROCESS | 1954 | RSS: Main: 278093824 15:13:01 INFO - PROCESS | 1954 | 15:13:04 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:13:05 INFO - PROCESS | 1954 | RSS: Main: 275058688 15:13:05 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54491/tests/kraken/driver.html?testName=ai-astar) 15:13:06 INFO - PROCESS | 1954 | RSS: Main: 336191488 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | __start_tp_report 15:13:06 INFO - PROCESS | 1954 | _x_x_mozilla_page_load 15:13:06 INFO - PROCESS | 1954 | _x_x_mozilla_page_load_details 15:13:06 INFO - PROCESS | 1954 | |i|pagename|runs| 15:13:06 INFO - PROCESS | 1954 | |0;ai-astar;113;115;119;113;112;112;114;113;114;135 15:13:06 INFO - PROCESS | 1954 | |1;audio-beat-detection;155;119;143;167;116;140;116;155;185;140 15:13:06 INFO - PROCESS | 1954 | |2;audio-dft;187;192;186;186;188;185;185;185;184;187 15:13:06 INFO - PROCESS | 1954 | |3;audio-fft;69;78;76;182;82;80;57;58;132;60 15:13:06 INFO - PROCESS | 1954 | |4;audio-oscillator;92;92;171;118;101;81;123;78;77;127 15:13:06 INFO - PROCESS | 1954 | |5;imaging-gaussian-blur;88;85;88;86;94;83;89;85;88;84 15:13:06 INFO - PROCESS | 1954 | |6;imaging-darkroom;92;93;93;94;93;93;93;93;92;93 15:13:06 INFO - PROCESS | 1954 | |7;imaging-desaturate;100;140;139;86;85;85;86;86;87;85 15:13:06 INFO - PROCESS | 1954 | |8;json-parse-financial;58;64;63;62;64;63;64;79;59;57 15:13:06 INFO - PROCESS | 1954 | |9;json-stringify-tinderbox;65;64;62;79;70;73;71;67;68;66 15:13:06 INFO - PROCESS | 1954 | |10;stanford-crypto-aes;81;77;78;91;93;93;105;77;80;84 15:13:06 INFO - PROCESS | 1954 | |11;stanford-crypto-ccm;122;122;124;123;135;141;122;126;145;142 15:13:06 INFO - PROCESS | 1954 | |12;stanford-crypto-pbkdf2;162;150;164;163;167;163;162;164;158;159 15:13:06 INFO - PROCESS | 1954 | |13;stanford-crypto-sha256-iterative;67;65;67;66;66;67;66;68;66;68 15:13:06 INFO - PROCESS | 1954 | __end_tp_report 15:13:06 INFO - PROCESS | 1954 | __start_cc_report 15:13:06 INFO - PROCESS | 1954 | _x_x_mozilla_cycle_collect,1932 15:13:06 INFO - PROCESS | 1954 | __end_cc_report 15:13:06 INFO - PROCESS | 1954 | __startTimestamp1468620786940__endTimestamp 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | ------- Summary: start ------- 15:13:06 INFO - PROCESS | 1954 | Number of tests: 14 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#0] ai-astar Cycles:10 Average:116.00 Median:114.00 stddev:6.98 (6.1%) stddev-sans-first:7.31 15:13:06 INFO - PROCESS | 1954 | Values: 113.0 115.0 119.0 113.0 112.0 112.0 114.0 113.0 114.0 135.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:149.00 stddev:22.79 (15.3%) stddev-sans-first:23.80 15:13:06 INFO - PROCESS | 1954 | Values: 155.0 119.0 143.0 167.0 116.0 140.0 116.0 155.0 185.0 140.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#2] audio-dft Cycles:10 Average:186.50 Median:186.50 stddev:2.27 (1.2%) stddev-sans-first:2.40 15:13:06 INFO - PROCESS | 1954 | Values: 187.0 192.0 186.0 186.0 188.0 185.0 185.0 185.0 184.0 187.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#3] audio-fft Cycles:10 Average:87.40 Median:72.50 stddev:39.61 (54.6%) stddev-sans-first:41.45 15:13:06 INFO - PROCESS | 1954 | Values: 69.0 78.0 76.0 182.0 82.0 80.0 57.0 58.0 132.0 60.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:77.50 stddev:29.37 (37.9%) stddev-sans-first:30.72 15:13:06 INFO - PROCESS | 1954 | Values: 92.0 92.0 171.0 118.0 101.0 81.0 123.0 78.0 77.0 127.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:3.16 (3.6%) stddev-sans-first:3.33 15:13:06 INFO - PROCESS | 1954 | Values: 88.0 85.0 88.0 86.0 94.0 83.0 89.0 85.0 88.0 84.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 15:13:06 INFO - PROCESS | 1954 | Values: 92.0 93.0 93.0 94.0 93.0 93.0 93.0 93.0 92.0 93.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:85.50 stddev:22.38 (26.2%) stddev-sans-first:23.73 15:13:06 INFO - PROCESS | 1954 | Values: 100.0 140.0 139.0 86.0 85.0 85.0 86.0 86.0 87.0 85.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:6.11 (9.6%) stddev-sans-first:6.17 15:13:06 INFO - PROCESS | 1954 | Values: 58.0 64.0 63.0 62.0 64.0 63.0 64.0 79.0 59.0 57.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:4.97 (7.2%) stddev-sans-first:5.11 15:13:06 INFO - PROCESS | 1954 | Values: 65.0 64.0 62.0 79.0 70.0 73.0 71.0 67.0 68.0 66.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:82.50 stddev:9.28 (11.2%) stddev-sans-first:9.67 15:13:06 INFO - PROCESS | 1954 | Values: 81.0 77.0 78.0 91.0 93.0 93.0 105.0 77.0 80.0 84.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:130.50 stddev:9.47 (7.3%) stddev-sans-first:9.57 15:13:06 INFO - PROCESS | 1954 | Values: 122.0 122.0 124.0 123.0 135.0 141.0 122.0 126.0 145.0 142.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:163.00 stddev:4.69 (2.9%) stddev-sans-first:4.96 15:13:06 INFO - PROCESS | 1954 | Values: 162.0 150.0 164.0 163.0 167.0 163.0 162.0 164.0 158.0 159.0 15:13:06 INFO - PROCESS | 1954 | 15:13:06 INFO - PROCESS | 1954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 15:13:06 INFO - PROCESS | 1954 | Values: 67.0 65.0 67.0 66.0 66.0 67.0 66.0 68.0 66.0 68.0 15:13:06 INFO - PROCESS | 1954 | -------- Summary: end -------- 15:13:06 INFO - PROCESS | 1954 | 15:13:07 INFO - TEST-INFO | 1954: exit 0 15:13:07 INFO - TEST-OK | kraken | took 57732ms 15:13:07 INFO - SUITE-END | took 1170s 15:13:08 INFO - Completed test suite (00:19:31) 15:13:08 INFO - javascript benchmark 15:13:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3519.9120021999456, 3576.856925722972, 3580.051286409104, 3607.8556857725694, 3674.2100448403603, 5983.341832398432, 6001.729922153502, 6023.518118550516, 6042.909356359647, 6048.6673232972225, 5982.641041537511, 6043.667598282103, 6046.365131661179, 6059.636421814695, 6071.332153463116, 5312.07038768216, 5361.410244873061, 5433.320834895638, 5440.836774896759, 5488.423715509874, 5418.512333889949, 5471.206675032118, 5471.206675032118, 5475.616706830523, 5482.479164479368, 5341.332333458317, 5414.756335964871, 5446.400895901447, 5446.754896029668, 5464.207689884965, 5174.948250517522, 5439.646422982493, 5480.26016487777, 5488.039593071197, 5506.834794956158, 5314.362276526842, 5314.97342513285, 5343.625946183769, 5399.352077750656, 5412.512873841334, 5801.419858014207, 5810.215620891167, 5829.0, 5830.825075247707, 5863.7686085922005, 6297.527685423612, 6321.683915804191, 6332.081848132041, 6333.303336632966, 6335.334789847092, 6245.781397651106, 6274.968625156891, 6332.461740751995, 6334.081558174085, 6378.394052564999, 6077.574569780118, 6078.604890682136, 6097.939020609826, 6104.4200800923845, 6107.236595425572, 6438.903416448757, 6461.773837915651, 6465.967670161619, 6476.838079048061, 6486.935130648728, 5083.491650834887, 6269.122322874801, 6329.936700632935, 6363.0, 6371.853066447991, 6300.149479820166, 6301.275353334334, 6304.747810087637, 6306.369363063657, 6309.08518264849, 6277.027060805583, 6332.651704156224, 6334.778282760081, 6349.682515874188, 6352.841178970562, 6269.811905642747, 6340.873182536416, 6360.491160707133, 6368.29948705642, 6379.904301435482, 5029.1953287473825, 5093.337866077386, 5102.4897510248675, 5102.872428189251, 5125.384953805567, 4575.084983003413, 4588.541145885451, 4589.472210695746, 4603.746793926299, 4621.861344159681, 5838.095095260242, 6034.577579569475, 6053.969730151321, 6071.726772295169, 6077.058056001327, 6284.968575157186, 6294.748210071546, 6359.427651511386, 6364.522660800459, 6373.203349581302, 6030.065339872327, 6065.484433823174, 6077.361877002851, 6080.969595151996, 6103.298120716175, 5474.124140137559, 5609.719514024282, 5632.831015069554, 5635.042042852725, 5638.43615638441, 6368.299487056513, 6463.127477790532, 6576.868462630625, 6580.8354791130605, 6598.175228096488, 6315.305316415099, 6335.873282534416, 6345.238571371465, 6349.555531112963, 6352.142460767737, 6422.3577642235405, 6493.74025039012, 6506.284308725942, 6513.934860651522, 6523.575967562093, 5249.9737501313775, 6270.184875966095, 6347.174867267226, 6362.618242905441, 6366.299707032315, 6258.374162583706, 6312.021636646327, 6339.0, 6345.93654063472, 6349.0476428536085, 4833.275008748576, 6018.548608854441, 6337.302896681269, 6348.5238607105575, 6365.14070600463, 5260.631755777059, 6269.216347956505, 6325.778597749057, 6329.556931014785, 6335.714892829741, 6221.346758590283, 6231.40801623845, 6265.874682506415, 6269.811905642838, 6276.811695648955, 5270.446603106772, 6200.0, 6232.844178895564, 6293.874122517433, 6295.024271237966, 6241.843953901007, 6282.277538082996, 6294.961331380271, 6296.968515157395, 6297.338779428094], "value": 5871.844424449262, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.1003569021889, 542.8572854142031, 551.0879494436706, 555.3585608622041, 567.8353277549511, 25512.362190945212, 32481.02556923296, 32504.0, 32549.349013019724, 32625.51061734076, 33157.66842331576, 33727.494087588646, 33737.83131084341, 40592.18815623686, 41302.0, 9593.856092158623, 9782.5597848097, 9786.217102631772, 9787.021297870227, 9805.215582753399, 9728.610855565768, 9868.851967220462, 9869.901300987007, 9874.456904870229, 9886.50567471627, 9197.356185067049, 9851.605935762596, 12092.395380230997, 12375.195612285217, 12407.56573519927, 11988.040956723442, 12116.575919842808, 12118.697032574168, 12129.0, 12133.27200367972, 12083.758324833541, 12215.022798176213, 12221.205621634654, 12224.205426647239, 12236.204646697935, 41291.1741765163, 41731.791341043405, 41740.37389439161, 41776.58223417757, 41816.79091604553, 3302.2239773653173, 3314.171457135716, 3500.43992961125, 3836.9424458633143, 4153.335466325373, 28893.0, 28984.0, 29756.958506452385, 30411.087667370015, 30838.920637777795, 2758.9310267243277, 2758.944821103587, 2770.1689493152176, 2824.1527541737396, 2850.2161905475955, 504882.0, 507727.0, 508748.0, 509087.0, 509091.0, 37190.07024824347, 37364.0, 54568.0, 66565.00152497717, 66799.0, 35823.283534329166, 35904.461433078526, 36015.63984360123, 36049.81975090108, 36121.45817812735, 16081.356745730274, 16226.756598651029, 16238.269277882524, 16241.918790405973, 16295.103769292802, 13626.0, 13680.863191368158, 13692.452301907811, 13702.657433564042, 13723.931380343034, 7223.386012188917, 7880.448368614257, 8059.5164290142775, 8272.296854767412, 8421.284190843724, 3296.456084746038, 3344.3311337732553, 3350.715189208896, 3419.3845107880325, 3549.432090865501, 996.5415908681942, 1011.0193112680688, 1055.8574592429923, 1131.6095946898306, 1135.9318440893574, 29930.102096937127, 30050.699493005228, 30088.699113008588, 30378.392432151675, 30650.38699226003, 1024.6618615856748, 1089.1722291058852, 1095.5289225632896, 1138.869030061537, 1153.6250718516517, 12497.437615307334, 12742.80885786714, 15300.234988250542, 15486.5354039379, 15773.526794195963, 639063.0, 643289.0, 643620.0, 644353.0, 644500.0, 62990.68504657447, 63942.040869387, 63991.36008639854, 64006.6799666008, 64160.71678566402, 1409.2319685771279, 1505.3903169216267, 1549.124744519343, 1560.2978659603225, 1570.6309017380906, 24495.75504245006, 29288.560671589516, 29933.55099673463, 29961.70038299676, 30649.0, 49152.0, 49452.0, 49455.7527212376, 49472.50527494823, 49985.00029999452, 352730.0, 354831.0, 355269.0, 607310.0, 649151.0, 27286.863565682044, 27413.0, 27866.303342416602, 27879.442411151256, 27919.302017449725, 45698.77150614226, 48389.0, 48576.0, 48656.0, 48946.0, 36957.63042369542, 37703.24593508169, 37733.05667358228, 37821.62178378291, 38608.0, 33136.834315828266, 38954.80522597369, 39029.2194156121, 39205.60794392019, 39711.40432893567, 39355.6064439352, 39721.60278397179, 39913.2017359657, 39951.40072898967, 40025.399619005155, 27147.72852271452, 27268.0, 33627.0, 34027.65972340245, 34079.82960085184, 25211.74788252094, 25433.491330173663, 25511.0, 25870.223893283233, 26032.958681652523], "value": 18913.395713939506, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.2338934665542, 417.42603919610497, 417.60327688695764, 417.7911044477761, 428.13089428460216, 21130.260440884555, 21131.0, 21214.257500987467, 21860.781392186072, 21869.68781873087, 17504.64990700185, 21913.013914373852, 22687.886560567214, 22710.659340109913, 22723.659145112837, 5655.519280861122, 6216.191895053659, 6229.626222426669, 6235.781747638834, 6251.562390632657, 6041.154238406627, 6061.333253342129, 6202.565820392574, 6208.689565521729, 6216.0, 6052.939470605282, 6145.815625531219, 6191.0, 6193.380661933793, 6196.225471816023, 5728.455796699307, 6169.969150154243, 6174.413430724074, 6179.536534759888, 6182.907256391158, 5881.588288819784, 5882.088276317178, 5885.4997325227405, 5888.97055514724, 5898.0, 15384.461543845911, 26280.0, 26623.46753064928, 26661.733382666313, 26687.466250675072, 1898.4968983219458, 2055.597985334259, 2222.344408399526, 2242.9102835886547, 2771.2656146121294, 10079.49602519871, 11313.264637798517, 13719.725605487934, 15194.392224311014, 15883.920580397024, 1809.8552115830835, 1836.2287839107607, 1888.424030670645, 1894.2991093295432, 1910.9140088696042, 105708.0, 114794.0, 117141.0, 117194.0, 118425.81574184234, 11834.644960651194, 11964.042876569854, 12042.518299267931, 12098.758024839453, 12115.697107572381, 15942.36230550765, 15961.36154553828, 16005.199740012953, 16020.0, 16022.919885400499, 9006.909930900738, 9313.580888860017, 9406.811863762823, 9446.197073248852, 9476.336656434121, 7548.622568871535, 9464.337496375188, 9476.857847132298, 9488.715338539854, 9599.856002159973, 4805.495422980606, 4827.95172048275, 4841.975790121097, 4859.465458799529, 4895.143349913751, 1717.5620216844625, 1989.3335732529765, 2058.989705051465, 2083.1875568528285, 2083.645780217367, 895.6730793260413, 987.7283746969497, 1011.4588695048261, 1033.266380869576, 1057.4025675493322, 20138.0, 21036.368908932756, 21265.255716050175, 21910.561788764135, 22038.44903877416, 959.1271942532262, 965.6764983730529, 976.3019441099648, 979.1432496565506, 1005.648023191877, 8581.95709021451, 11424.714382140513, 11670.649880503599, 11702.473388697528, 11764.764704705858, 660960.0, 662663.0, 673510.0, 677111.0, 678636.0, 132926.0, 137963.31018344843, 138653.61346386408, 139035.0, 142437.0, 890.496869268861, 1010.4796030044533, 1018.1447584029303, 1028.5063169678747, 1032.488917985587, 18728.344507942158, 18896.811031889505, 19303.8069619302, 20076.19695212175, 20199.79800202038, 39266.80366598149, 48784.51215487799, 50241.0, 53351.0, 55075.724621376634, 64804.35195647983, 73350.89973650292, 74686.0, 75920.0, 76383.23616763762, 8481.15188481147, 8594.35542334315, 8620.267277281502, 8889.4666320021, 9140.588673509576, 7420.109586849612, 11009.61466348674, 12088.939555302168, 13199.152118703581, 13551.98360122975, 11735.647930562096, 11861.288322700666, 11955.0, 12045.457954391899, 12073.939630301793, 9791.873934497624, 11613.361265130161, 11775.705607359541, 11811.50732707811, 11908.225965312227, 9927.553260103457, 11842.0, 11928.522859085539, 11988.0, 12018.819717704417, 8445.66217351299, 8564.0, 8896.154865287788, 8989.505577193317, 9111.544422778967, 10723.410212438392, 11000.614978475714, 11226.607068752555, 11266.774664506827, 11424.485898134437], "value": 9967.75546630755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.8063251777266, 1612.2986500872119, 1632.5428879913625, 1896.3647178195304, 2011.9396418107463, 7529.774106776792, 8262.958685206573, 8825.735227943163, 8987.820243595132, 8992.415492992966, 8705.782355441117, 8931.41945773526, 8943.41867778594, 8944.731658050268, 8957.596908139132, 2519.962200566993, 2541.2376287113884, 2547.6688030556, 2552.5660637691635, 2553.221267513408, 2468.8518688878635, 2535.657686212365, 2539.7460253974546, 2541.136013755323, 2556.8593727344987, 2122.5330427306044, 2517.748225177486, 2546.8726563671835, 2560.28312072619, 2571.7299683533242, 2516.3960649444093, 2550.795936325099, 2561.5389229938605, 2562.7309132541, 2563.6410902473667, 2506.0477018732763, 2538.5430622487943, 2549.375403026252, 2549.974500254992, 2564.551203539373, 8847.513386763725, 9042.095790420972, 9104.044075372056, 9149.77125571866, 9167.991520932692, 5639.830805075854, 5835.824925252249, 5837.941620583825, 5852.619579727347, 5853.209816674737, 3187.474066778979, 3662.7436079474446, 3749.512563366772, 3797.2215695782297, 3800.3919372900205, 1040.3705758016442, 1068.8610480637467, 1070.5985255529176, 1086.3536195963388, 1110.5335758981248, 12384.938075309567, 12639.241645501208, 12641.36793160329, 12659.683507912283, 12673.619791406272, 4802.783874725646, 4845.176320025604, 4860.756962151878, 4879.219324907997, 4888.95111048885, 9652.27607929394, 9671.419714817133, 9678.128968392879, 9678.225741940629, 9678.75803104928, 5610.186522954149, 5647.745851436695, 5652.378238393773, 5660.0, 5660.830175094754, 4610.331501932201, 4778.235482322882, 5080.898382032413, 5204.739763011834, 5244.423113457517, 3986.80065996699, 4001.139754952641, 4077.898052548651, 4105.733127346773, 4118.361653943643, 1263.696712788924, 1267.163671976491, 1269.9809502857465, 1279.4690203565601, 1279.9232046077266, 945.0785484153033, 967.4678926590487, 975.3708857786829, 984.7193549838262, 1011.8735158105237, 6083.270007599116, 6163.599366041193, 6210.4100110489435, 6289.842753931097, 6331.96834015827, 468.64148926071584, 482.36568911881466, 490.4923404276557, 498.12081675842165, 499.88752530681035, 3965.20695860829, 4053.6959728020515, 4089.6728261739586, 4122.216778812016, 4150.91698166035, 11154.386508741934, 11603.883961160449, 11645.184837061324, 11694.2983420995, 11723.472443740053, 10572.0, 11229.0, 11359.829602555968, 11391.259568128045, 11412.942935285271, 8601.956990215134, 8631.352648551383, 8672.913270867211, 8763.123687631314, 8769.736907892773, 5065.45503621399, 5940.227770389822, 5944.613600115978, 6195.132681424514, 6196.783112591038, 9955.900440995498, 9998.60005599797, 10158.492075396349, 10162.136218421518, 10177.033181847713, 9966.551505182138, 10378.117859981987, 10451.320664156805, 10875.075618572193, 10903.890961090288, 7098.077249957472, 7274.236205198378, 7587.848243035219, 7929.127795942326, 8039.638216280398, 8586.184312490303, 8598.097199793932, 8658.134186581292, 8658.913410866062, 8694.30445564366, 7480.251974802476, 7500.212477689764, 7561.6597253122645, 7676.80807979805, 7697.461177717506, 7414.295641914009, 7442.516236444614, 7455.0681164854395, 7530.887036694564, 7584.924150758642, 7186.0, 7308.342249197598, 7329.560226386434, 7331.926680733124, 7343.522671026366, 4970.776315065903, 4993.950060499348, 5120.846374608767, 5152.742362881916, 5185.896282074413, 5039.143345631325, 5074.923876141787, 5086.872828179326, 5186.273921651047, 5319.015982043335], "value": 4688.334500115978, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.4398388715015, 337.2714935738803, 341.1352222116933, 345.5939271356156, 348.68444058127403, 6713.462922966163, 6732.2931092235285, 6760.966195169023, 6790.0, 6809.489288303373, 6705.094812200351, 6706.39642432181, 6711.798646040615, 6741.797746067626, 6745.426638735713, 4747.074320507502, 4859.829905953292, 4865.708057516543, 4954.355933728611, 5008.048470790556, 4945.332380128691, 5006.424261209971, 5014.749262536877, 5022.0709168803705, 5044.545990860822, 4968.229924361712, 4971.428285747131, 4974.87562810929, 4980.377452818398, 4993.900121997558, 4031.2743706132883, 4797.280407938802, 4832.492588278233, 4898.5591296783105, 4924.876878078041, 4203.55862634422, 4221.155768846213, 4230.17511585241, 4233.767142807144, 4235.957640423618, 5032.446430892599, 6315.305316415191, 6319.210098737658, 6376.521760867907, 6391.712372943229, 4846.29728689338, 5751.76337087524, 5855.76576936922, 5862.977272840906, 5867.823965281048, 6858.8215896997945, 7096.787096387065, 7097.325754053409, 7099.964500177518, 7103.502754807166, 4751.049790042005, 4799.992001679651, 4809.807607695688, 4810.35060266863, 4810.903781924342, 5923.970380148072, 5985.850353741192, 7531.397488200931, 7541.472096953215, 7579.355754760852, 4861.611071114302, 4881.389826271716, 4886.047220791983, 4888.780004899788, 4899.363082799213, 4959.70241785494, 4962.528559786887, 4966.6771659842, 4971.602271818246, 4982.476839931827, 5094.497123348621, 5487.38122253928, 5889.676067816311, 5891.3224979127945, 5892.6759028253855, 6250.718717657716, 6844.349786770249, 7079.221285658574, 7177.856442871113, 7200.1359836818865, 1416.504223521759, 1704.9829501705071, 1720.5010546941246, 1739.3129713762992, 1740.5387572293353, 1037.3516552154904, 1049.4070849969742, 1094.392612100276, 1104.629948967089, 1123.039800970175, 6614.470842332602, 6769.966150169218, 6812.284710105467, 6823.215330237086, 6830.385265326145, 7580.772576822704, 7593.734219302409, 7604.8479030419085, 7608.923910760932, 7611.2769286917655, 6782.559133656297, 6791.66041697923, 6795.626240556718, 6799.5920244785475, 6824.829379265558, 3799.0502374406396, 3957.56466788653, 3985.0, 3988.4017397390626, 3996.760194388346, 7777.300042996158, 7797.259260370256, 7806.531608103532, 7810.297073263434, 7877.369810415267, 6586.407223349922, 7525.661345239478, 7757.3794096473275, 7783.649735761905, 7835.804104897309, 7854.685812567547, 7868.291853733192, 7870.724524641724, 7879.054513458307, 7883.2905038546805, 7230.674619642024, 7510.211427800221, 7514.436417268836, 7535.962320188364, 7546.396288297033, 7351.632418378953, 7380.926190738239, 7381.630918453949, 7400.629968501661, 7405.44459165554, 6378.74485020594, 7382.003429537159, 7874.21257874208, 7884.329831964347, 7895.7236496722335, 4075.3071977764444, 4687.9765601171775, 4700.741459219776, 4706.764661766966, 4711.057788442256, 7225.530340527849, 7453.844654078626, 7482.2517748224745, 7487.401007919245, 7499.325060744559, 7202.279772022755, 7210.0, 7235.0, 7245.710171593078, 7252.854942901218, 7211.810051341679, 7214.2785721427435, 7231.566106033655, 7258.0, 7276.672549735381, 7049.577025378494, 7055.259197784364, 7072.611006394698, 7093.680784364613, 7098.964505177441, 7037.085178926707, 7119.0, 7171.3545780877885, 7212.206657267591, 7214.74748383804, 6798.694058767466, 6871.175458944958, 6994.475414344046, 6996.6151861648095, 7011.3339232772805], "value": 5249.989118440079, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.8263651450627, 715.9928400715993, 780.3562061299426, 785.2461636828641, 795.4193438789683, 15347.3093710783, 15717.13555754433, 15731.370745170208, 15739.84260157398, 15744.212789360528, 14236.501722439716, 14487.637809054779, 14488.637784055378, 14490.5652830415, 14497.710045799078, 764.3579393309604, 782.5304817109745, 786.4180506425262, 787.0476723164977, 787.3189690917344, 771.9382449404034, 953.2612225525204, 956.2588993530001, 957.4638202606562, 958.2142643032716, 995.4922989275449, 1005.4972513743129, 1007.5163921317771, 1007.7480629842539, 1008.485672307125, 811.5577010529275, 997.4514017290497, 1000.8398656215044, 1001.7345403468087, 1002.0780881588955, 731.1445608637906, 758.981025474362, 759.7758661194961, 763.3206446262775, 763.385474692872, 15216.619584510365, 15238.695226095417, 15259.465918692904, 15271.312790924323, 15295.770563441558, 12927.87072129276, 12952.352382380843, 13250.867491325156, 13333.133451263704, 13367.398467069006, 10383.169346452265, 10456.215783816167, 10598.470076496144, 10818.945905270502, 10898.237123401364, 3068.5704001439817, 3609.903044328278, 3628.2562074774874, 3701.777893326382, 3858.131920317934, 77886.22113778847, 78434.60782696107, 78530.21469785286, 78543.60728196379, 79772.0, 8426.199511046441, 9068.773280667903, 9506.714798556055, 9562.713118606453, 9599.520023998772, 21747.565048698936, 21756.0, 21797.67303490449, 21814.236501722364, 21841.235556755437, 6837.042814006043, 7527.134379546313, 7631.809204769926, 7700.268474494914, 7843.254890785366, 4252.0, 4303.548127446636, 4333.414988976448, 4388.188185185751, 4457.866264012085, 3690.741648084662, 3738.7569807962395, 3743.2513497300647, 3746.5316835395574, 3764.5294338207723, 672.4519516594058, 688.5421194905332, 701.3617607976716, 714.085969958454, 723.2947875821137, 596.955228357875, 613.7943788830792, 622.9781957631461, 629.5058379172327, 630.4011189370117, 7724.691012359555, 8162.020557533134, 8264.710735124241, 8343.874841877378, 8544.957275213585, 593.9109133629904, 596.5078809981783, 613.7268915332724, 623.0094846963997, 642.4795915308522, 3796.4495148203355, 3829.7893615851394, 3855.151866589346, 3886.805659717003, 3944.2900277950243, 79026.0, 85414.57292713497, 86798.56600716956, 87149.0, 87705.68441473383, 75490.62254688801, 76404.0, 76637.6168119167, 76675.0, 78147.0, 68552.6572367135, 68600.6569967157, 68625.65687171533, 68979.62040759157, 70216.64891675509, 7851.764447066597, 7881.620716374497, 8485.95757021211, 8487.618057187565, 8593.484390936565, 48482.51517484921, 49152.50847491479, 49194.75402622964, 49517.752411237714, 49857.75071124621, 67125.62994960489, 67263.66368168128, 67877.3212267871, 68421.23683197272, 68999.3100068993, 10994.615188468366, 11066.948639879198, 11294.096472282363, 11477.909598588121, 11562.88437115618, 11883.405829708307, 12166.209196402206, 12204.938975305422, 12404.875951240372, 12616.810747838974, 11707.121965852766, 11723.0, 11742.297366881925, 11782.99844513226, 11794.941025294818, 11486.885131148581, 11565.537378504765, 11649.0, 11667.824982625438, 11959.581414650445, 10852.459504083085, 10968.957948994832, 11138.0, 11570.247933884271, 11662.12534059932, 7792.454528182972, 9486.418079996734, 9730.659426920023, 9851.0, 9950.253730970062, 9429.905700942903, 9680.080392362714, 9736.464494452874, 9779.85330220033, 9802.509874506104], "value": 7001.972474804452, "unit": "score"}], "name": "dromaeo_css", "value": 7587.444755263671, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 119.0, 113.0, 112.0, 112.0, 114.0, 113.0, 114.0, 135.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 119.0, 143.0, 167.0, 116.0, 140.0, 116.0, 155.0, 185.0, 140.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 192.0, 186.0, 186.0, 188.0, 185.0, 185.0, 185.0, 184.0, 187.0], "value": 186.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 76.0, 182.0, 82.0, 80.0, 57.0, 58.0, 132.0, 60.0], "value": 87.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 171.0, 118.0, 101.0, 81.0, 123.0, 78.0, 77.0, 127.0], "value": 106.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 94.0, 83.0, 89.0, 85.0, 88.0, 84.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 140.0, 139.0, 86.0, 85.0, 85.0, 86.0, 86.0, 87.0, 85.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 63.0, 62.0, 64.0, 63.0, 64.0, 79.0, 59.0, 57.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 79.0, 70.0, 73.0, 71.0, 67.0, 68.0, 66.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 78.0, 91.0, 93.0, 93.0, 105.0, 77.0, 80.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 124.0, 123.0, 135.0, 141.0, 122.0, 126.0, 145.0, 142.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 150.0, 164.0, 163.0, 167.0, 163.0, 162.0, 164.0, 158.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 66.0, 66.0, 67.0, 66.0, 68.0, 66.0, 68.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1493.0, "alertThreshold": 2.0}]} 15:13:08 INFO - Return code: 0 15:13:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:13:08 ERROR - # TBPL SUCCESS # 15:13:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:13:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:13:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:13:08 INFO - 2016-07-15 15:13:08.264 screenresolution[1958:20012] starting screenresolution argv=screenresolution get 15:13:08 INFO - 2016-07-15 15:13:08.266 screenresolution[1958:20012] Display 0: 1600x1200x32@60 15:13:08 INFO - 2016-07-15 15:13:08.272 screenresolution[1959:20015] starting screenresolution argv=screenresolution list 15:13:08 INFO - Available Modes on Display 0 15:13:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:13:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:13:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:13:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:13:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:13:08 INFO - Intel Iris: 15:13:08 INFO - Chipset Model: Intel Iris 15:13:08 INFO - Type: GPU 15:13:08 INFO - Bus: Built-In 15:13:08 INFO - VRAM (Dynamic, Max): 1536 MB 15:13:08 INFO - Vendor: Intel (0x8086) 15:13:08 INFO - Device ID: 0x0a2e 15:13:08 INFO - Revision ID: 0x0009 15:13:08 INFO - Displays: 15:13:08 INFO - Display: 15:13:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:13:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:13:08 INFO - Display Serial Number: 1600x1200 60 15:13:08 INFO - Main Display: Yes 15:13:08 INFO - Mirror: Off 15:13:08 INFO - Online: Yes 15:13:08 INFO - Rotation: Supported 15:13:08 INFO - Return code: 0 15:13:08 INFO - Running post-action listener: _resource_record_post_action 15:13:08 INFO - Running post-run listener: _resource_record_post_run 15:13:09 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 1007616; Write bytes: 493061120; Read time: 14; Write time: 1816 15:13:09 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191107584; Write bytes: 187529216; Read time: 17380; Write time: 449 15:13:09 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 1007616; Write bytes: 294738944; Read time: 14; Write time: 1335 15:13:09 INFO - Running post-run listener: _upload_blobber_files 15:13:09 INFO - Blob upload gear active. 15:13:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:13:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:13:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:13:09 INFO - (blobuploader) - INFO - Open directory for files ... 15:13:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:13:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:13:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:11 INFO - (blobuploader) - INFO - Done attempting. 15:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:13:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:12 INFO - (blobuploader) - INFO - Done attempting. 15:13:12 INFO - (blobuploader) - INFO - Iteration through files over. 15:13:12 INFO - Return code: 0 15:13:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:13:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:13:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/055f0582aa2c24c794e22b4ba9ef2e2b83b536027a29730bbd16344a4a3eb6346ff38c82b7ccf4f137586d80b3fe00560a70616fd7118ebb812afe1dc243c455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/495559a6a72ce3426b9be092a9c4f38201379a63fbda629892df4790c658b7454b3a7f3dd54d8f51d616a0534272e53313487493ff1ace30f768c9407c969e7f"} 15:13:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:13:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:13:12 INFO - Contents: 15:13:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/055f0582aa2c24c794e22b4ba9ef2e2b83b536027a29730bbd16344a4a3eb6346ff38c82b7ccf4f137586d80b3fe00560a70616fd7118ebb812afe1dc243c455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/495559a6a72ce3426b9be092a9c4f38201379a63fbda629892df4790c658b7454b3a7f3dd54d8f51d616a0534272e53313487493ff1ace30f768c9407c969e7f"} 15:13:12 INFO - Running post-run listener: copy_logs_to_upload_dir 15:13:12 INFO - Copying logs to upload dir... 15:13:12 INFO - mkdir: /builds/slave/test/build/upload/logs 15:13:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.782721 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-15 15:13:12.803874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 15:13:12.807511) ========= 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.eaPq3bscuQ/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.7i1zLToSSA/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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/055f0582aa2c24c794e22b4ba9ef2e2b83b536027a29730bbd16344a4a3eb6346ff38c82b7ccf4f137586d80b3fe00560a70616fd7118ebb812afe1dc243c455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/495559a6a72ce3426b9be092a9c4f38201379a63fbda629892df4790c658b7454b3a7f3dd54d8f51d616a0534272e53313487493ff1ace30f768c9407c969e7f"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011015 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468347597/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/055f0582aa2c24c794e22b4ba9ef2e2b83b536027a29730bbd16344a4a3eb6346ff38c82b7ccf4f137586d80b3fe00560a70616fd7118ebb812afe1dc243c455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/495559a6a72ce3426b9be092a9c4f38201379a63fbda629892df4790c658b7454b3a7f3dd54d8f51d616a0534272e53313487493ff1ace30f768c9407c969e7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 15:13:12.841862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:13:12.842390) ========= 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.eaPq3bscuQ/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.7i1zLToSSA/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005149 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:13:12.893037) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 15:13:12.893576) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 15:13:12.894138) ========= ========= Total master_lag: 0.18 =========