builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0230 starttime: 1469562623.51 results: success (0) buildid: 20160726073758 builduid: 89b706416f5c44008f6e4c4cb7cc5e0b revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:23.505896) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:23.506498) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:23.506898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:23.535883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:23.536708) ========= 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.6R9WdPCTRF/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.0s8nemmtfa/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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-26 12:50:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.7M=0.001s 2016-07-26 12:50:23 (17.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103004 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:23.664926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:23.665244) ========= 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.6R9WdPCTRF/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.0s8nemmtfa/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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.025853 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:23.713985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 12:50:23.714327) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 958cee08361af9ed370be06695973bcda3d3aa46 --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 958cee08361af9ed370be06695973bcda3d3aa46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6R9WdPCTRF/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.0s8nemmtfa/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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-26 12:50:23,793 truncating revision to first 12 chars 2016-07-26 12:50:23,793 Setting DEBUG logging. 2016-07-26 12:50:23,793 attempt 1/10 2016-07-26 12:50:23,793 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/958cee08361a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 12:50:24,501 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986348 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 12:50:24.723865) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:24.724193) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:24.724637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:24.724925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 12:50:24.745373) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-26 12:50:24.745726) ========= /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.6R9WdPCTRF/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.0s8nemmtfa/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 12:50:24 INFO - MultiFileLogger online at 20160726 12:50:24 in /builds/slave/test 12:50:24 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 12:50:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:24 INFO - {'append_to_log': False, 12:50:24 INFO - 'base_work_dir': '/builds/slave/test', 12:50:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:50:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:24 INFO - 'branch': 'Mozilla-Beta', 12:50:24 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:24 INFO - 'config_files': ('talos/mac_config.py',), 12:50:24 INFO - 'default_actions': ('clobber', 12:50:24 INFO - 'read-buildbot-config', 12:50:24 INFO - 'download-and-extract', 12:50:24 INFO - 'populate-webroot', 12:50:24 INFO - 'create-virtualenv', 12:50:24 INFO - 'install', 12:50:24 INFO - 'run-tests'), 12:50:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:24 INFO - 'download_minidump_stackwalk': True, 12:50:24 INFO - 'download_symbols': 'ondemand', 12:50:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:50:24 INFO - 'tooltool.py': '/tools/tooltool.py', 12:50:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:50:24 INFO - '/tools/misc-python/virtualenv.py')}, 12:50:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:24 INFO - 'installer_path': 'installer.exe', 12:50:24 INFO - 'log_level': 'info', 12:50:24 INFO - 'log_name': 'talos', 12:50:24 INFO - 'log_to_console': True, 12:50:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:50:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:50:24 INFO - 'opt_config_files': (), 12:50:24 INFO - 'pip_index': False, 12:50:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:50:24 INFO - 'cmd': ('bash', 12:50:24 INFO - '-c', 12:50:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:50:24 INFO - 'enabled': True, 12:50:24 INFO - 'halt_on_failure': False, 12:50:24 INFO - 'name': 'check_screen_resolution'},), 12:50:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:50:24 INFO - 'cmd': ('bash', 12:50:24 INFO - '-c', 12:50:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:50:24 INFO - 'enabled': True, 12:50:24 INFO - 'halt_on_failure': False, 12:50:24 INFO - 'name': 'check_screen_resolution'},), 12:50:24 INFO - 'run_cmd_checks_enabled': True, 12:50:24 INFO - 'sps_profile': False, 12:50:24 INFO - 'sps_profile_interval': 0, 12:50:24 INFO - 'suite': 'dromaeojs', 12:50:24 INFO - 'system_bits': '32', 12:50:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:24 INFO - 'title': 't-yosemite-r7-0230', 12:50:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:24 INFO - 'use_talos_json': True, 12:50:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:24 INFO - 'work_dir': 'build'} 12:50:24 INFO - ##### 12:50:24 INFO - ##### Running clobber step. 12:50:24 INFO - ##### 12:50:24 INFO - Running pre-action listener: _resource_record_pre_action 12:50:24 INFO - Running main action method: clobber 12:50:24 INFO - rmtree: /builds/slave/test/build 12:50:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:26 INFO - Running post-action listener: _resource_record_post_action 12:50:26 INFO - ##### 12:50:26 INFO - ##### Running read-buildbot-config step. 12:50:26 INFO - ##### 12:50:26 INFO - Running pre-action listener: _resource_record_pre_action 12:50:26 INFO - Running main action method: read_buildbot_config 12:50:26 INFO - Using buildbot properties: 12:50:26 INFO - { 12:50:26 INFO - "project": "", 12:50:26 INFO - "product": "firefox", 12:50:26 INFO - "script_repo_revision": "production", 12:50:26 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:50:26 INFO - "repository": "", 12:50:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:50:26 INFO - "buildid": "20160726073758", 12:50:26 INFO - "pgo_build": "False", 12:50:26 INFO - "basedir": "/builds/slave/test", 12:50:26 INFO - "buildnumber": 55, 12:50:26 INFO - "slavename": "t-yosemite-r7-0230", 12:50:26 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:50:26 INFO - "platform": "yosemite_r7", 12:50:26 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:50:26 INFO - "branch": "mozilla-beta", 12:50:26 INFO - "repo_path": "releases/mozilla-beta", 12:50:26 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 12:50:26 INFO - "stage_platform": "macosx64", 12:50:26 INFO - "builduid": "89b706416f5c44008f6e4c4cb7cc5e0b", 12:50:26 INFO - "slavebuilddir": "test" 12:50:26 INFO - } 12:50:26 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.dmg. 12:50:26 INFO - Running post-action listener: _resource_record_post_action 12:50:26 INFO - ##### 12:50:26 INFO - ##### Running download-and-extract step. 12:50:26 INFO - ##### 12:50:26 INFO - Running pre-action listener: _resource_record_pre_action 12:50:26 INFO - Running main action method: download_and_extract 12:50:26 INFO - mkdir: /builds/slave/test/build/tests 12:50: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')]} 12:50:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.test_packages.json 12:50:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 12:50:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/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 12:50:27 INFO - Downloaded 1165 bytes. 12:50:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 12:50:27 INFO - Using the following test package requirements: 12:50:27 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 12:50:27 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:27 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 12:50:27 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:27 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 12:50:27 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:50:27 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:27 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 12:50:27 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 12:50:27 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:27 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 12:50:27 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:27 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 12:50:27 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:27 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 12:50:27 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:27 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 12:50:27 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 12:50:27 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')]} 12:50:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.common.tests.zip 12:50:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 12:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/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 12:50:27 INFO - Downloaded 18314895 bytes. 12:50:27 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'] 12:50:27 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 12:50:30 INFO - Return code: 0 12:50:30 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 12:50: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')]} 12:50:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.common.tests.zip 12:50:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 12:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/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 12:50:30 INFO - Downloaded 18314895 bytes. 12:50:30 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'] 12:50:30 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 12:50:34 INFO - Return code: 0 12:50:34 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')]} 12:50:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.talos.tests.zip 12:50:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 12:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/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 12:50:34 INFO - Downloaded 10840145 bytes. 12:50:34 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'] 12:50:34 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 12:50:34 INFO - Return code: 0 12:50:34 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')]} 12:50:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.dmg 12:50:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 12:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 12:50:35 INFO - Downloaded 86256154 bytes. 12:50:35 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.dmg 12:50:35 INFO - mkdir: /builds/slave/test/properties 12:50:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:35 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:35 INFO - Contents: 12:50:35 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.dmg 12:50:35 INFO - Running post-action listener: _resource_record_post_action 12:50:35 INFO - Running post-action listener: set_extra_try_arguments 12:50:35 INFO - ##### 12:50:35 INFO - ##### Running populate-webroot step. 12:50:35 INFO - ##### 12:50:35 INFO - Running pre-action listener: _resource_record_pre_action 12:50:35 INFO - Running main action method: populate_webroot 12:50:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:50:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:50:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:50:35 INFO - '--tppagecycles', 12:50:35 INFO - '7'], 12:50:35 INFO - 'tests': ['tsvgm']}}, 12:50:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:50:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:50:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:50:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:50:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:50:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:50:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:35 INFO - 'talos_options': ['--disable-e10s'], 12:50:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:35 INFO - 'talos_options': ['--disable-e10s'], 12:50:35 INFO - 'tests': ['damp', 'tps']}, 12:50:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:35 INFO - 'tests': ['damp', 'tps']}, 12:50:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:50:35 INFO - 'tests': ['dromaeo_dom']}, 12:50:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:50:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:50:35 INFO - 'tests': ['a11yr', 12:50:35 INFO - 'ts_paint', 12:50:35 INFO - 'tpaint', 12:50:35 INFO - 'sessionrestore', 12:50:35 INFO - 'sessionrestore_no_auto_restore', 12:50:35 INFO - 'tabpaint']}, 12:50:35 INFO - 'other-e10s': {'tests': ['a11yr', 12:50:35 INFO - 'ts_paint', 12:50:35 INFO - 'tpaint', 12:50:35 INFO - 'sessionrestore', 12:50:35 INFO - 'sessionrestore_no_auto_restore', 12:50:35 INFO - 'tabpaint']}, 12:50:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:50:35 INFO - 'ts_paint', 12:50:35 INFO - 'tpaint', 12:50:35 INFO - 'sessionrestore', 12:50:35 INFO - 'sessionrestore_no_auto_restore', 12:50:35 INFO - 'tabpaint']}, 12:50:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:50:35 INFO - 'ts_paint', 12:50:35 INFO - 'tpaint', 12:50:35 INFO - 'sessionrestore', 12:50:35 INFO - 'sessionrestore_no_auto_restore', 12:50:35 INFO - 'tabpaint']}, 12:50:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:50:35 INFO - 'tests': ['a11yr', 12:50:35 INFO - 'ts_paint', 12:50:35 INFO - 'tpaint', 12:50:35 INFO - 'sessionrestore', 12:50:35 INFO - 'sessionrestore_no_auto_restore', 12:50:35 INFO - 'tabpaint']}, 12:50:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:50:35 INFO - 'tests': ['a11yr', 12:50:35 INFO - 'ts_paint', 12:50:35 INFO - 'tpaint', 12:50:35 INFO - 'sessionrestore', 12:50:35 INFO - 'sessionrestore_no_auto_restore', 12:50:35 INFO - 'tabpaint']}, 12:50:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:50:35 INFO - 'tests': ['tsvgx', 12:50:35 INFO - 'tsvgr_opacity', 12:50:35 INFO - 'tart', 12:50:35 INFO - 'tscrollx', 12:50:35 INFO - 'cart']}, 12:50:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:50:35 INFO - 'tsvgr_opacity', 12:50:35 INFO - 'tart', 12:50:35 INFO - 'tscrollx', 12:50:35 INFO - 'cart']}, 12:50:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:35 INFO - 'talos_options': ['--disable-e10s'], 12:50:35 INFO - 'tests': ['tp5o']}, 12:50:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:35 INFO - 'tests': ['tp5o']}, 12:50:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:35 INFO - 'talos_options': ['--disable-e10s', 12:50:35 INFO - '--xperf_path', 12:50:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:35 INFO - 'tests': ['tp5n']}, 12:50:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:35 INFO - 'talos_options': ['--xperf_path', 12:50:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:35 INFO - 'tests': ['tp5n']}}, 12:50:35 INFO - 'talos.zip': {'path': '', 12:50:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:50:35 INFO - Running post-action listener: _resource_record_post_action 12:50:35 INFO - ##### 12:50:35 INFO - ##### Running create-virtualenv step. 12:50:35 INFO - ##### 12:50:35 INFO - Running pre-action listener: _resource_record_pre_action 12:50:35 INFO - Running main action method: create_virtualenv 12:50:35 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:35 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 12:50:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:50:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:36 INFO - Using real prefix '/tools/python27' 12:50:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:36 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:39 INFO - Installing pip.................done. 12:50:39 INFO - Return code: 0 12:50:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10885da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faeb35a2200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fce00>, '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 0x108565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f7b20>, '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.6R9WdPCTRF/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.0s8nemmtfa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 12:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:50:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6R9WdPCTRF/Render', 12:50:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:39 INFO - 'HOME': '/Users/cltbld', 12:50:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:39 INFO - 'LOGNAME': 'cltbld', 12:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:39 INFO - 'MOZ_NO_REMOTE': '1', 12:50:39 INFO - 'NO_EM_RESTART': '1', 12:50:39 INFO - 'PAGER': '/bin/cat', 12:50:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:39 INFO - 'PWD': '/builds/slave/test', 12:50:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:39 INFO - 'SHELL': '/bin/bash', 12:50:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0s8nemmtfa/Listeners', 12:50:39 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 12:50:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:39 INFO - 'USER': 'cltbld', 12:50:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:39 INFO - 'XPC_FLAGS': '0x0', 12:50:39 INFO - 'XPC_SERVICE_NAME': '0', 12:50:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:39 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 12:50:39 INFO - Cleaning up... 12:50:39 INFO - Return code: 0 12:50:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10885da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faeb35a2200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fce00>, '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 0x108565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f7b20>, '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.6R9WdPCTRF/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.0s8nemmtfa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 12:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:50:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6R9WdPCTRF/Render', 12:50:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:39 INFO - 'HOME': '/Users/cltbld', 12:50:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:39 INFO - 'LOGNAME': 'cltbld', 12:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:39 INFO - 'MOZ_NO_REMOTE': '1', 12:50:39 INFO - 'NO_EM_RESTART': '1', 12:50:39 INFO - 'PAGER': '/bin/cat', 12:50:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:39 INFO - 'PWD': '/builds/slave/test', 12:50:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:39 INFO - 'SHELL': '/bin/bash', 12:50:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0s8nemmtfa/Listeners', 12:50:39 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 12:50:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:39 INFO - 'USER': 'cltbld', 12:50:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:39 INFO - 'XPC_FLAGS': '0x0', 12:50:39 INFO - 'XPC_SERVICE_NAME': '0', 12:50:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:40 INFO - Downloading/unpacking psutil>=0.7.1 12:50:40 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 12:50:40 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 12:50:40 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 12:50:40 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 12:50:40 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 12:50:40 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 12:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:43 INFO - Installing collected packages: psutil 12:50:43 INFO - Running setup.py install for psutil 12:50:43 INFO - building 'psutil._psutil_osx' extension 12:50:43 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 12:50:43 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 12:50:43 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 12:50:44 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 12:50:44 INFO - building 'psutil._psutil_posix' extension 12:50:44 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 12:50:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:50:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:50:44 INFO - ^ 12:50:44 INFO - 1 warning generated. 12:50:44 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 12:50:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:44 INFO - Successfully installed psutil 12:50:44 INFO - Cleaning up... 12:50:44 INFO - Return code: 0 12:50:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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', '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 0x10885da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faeb35a2200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fce00>, '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 0x108565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f7b20>, '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.6R9WdPCTRF/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.0s8nemmtfa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 12:50: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:50: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 mozsystemmonitor==0.0.0 12:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6R9WdPCTRF/Render', 12:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:44 INFO - 'HOME': '/Users/cltbld', 12:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:44 INFO - 'LOGNAME': 'cltbld', 12:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:44 INFO - 'MOZ_NO_REMOTE': '1', 12:50:44 INFO - 'NO_EM_RESTART': '1', 12:50:44 INFO - 'PAGER': '/bin/cat', 12:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:44 INFO - 'PWD': '/builds/slave/test', 12:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:44 INFO - 'SHELL': '/bin/bash', 12:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0s8nemmtfa/Listeners', 12:50:44 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 12:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:44 INFO - 'USER': 'cltbld', 12:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:44 INFO - 'XPC_FLAGS': '0x0', 12:50:44 INFO - 'XPC_SERVICE_NAME': '0', 12:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:50:47 INFO - Installing collected packages: mozsystemmonitor 12:50:47 INFO - Running setup.py install for mozsystemmonitor 12:50:47 INFO - Successfully installed mozsystemmonitor 12:50:47 INFO - Cleaning up... 12:50:47 INFO - Return code: 0 12:50:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:50:47 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')]} 12:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:47 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')]} 12:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:47 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 0x10885da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faeb35a2200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fce00>, '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 0x108565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f7b20>, '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.6R9WdPCTRF/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.0s8nemmtfa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 12:50:47 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 12:50:47 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 12:50:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6R9WdPCTRF/Render', 12:50:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:47 INFO - 'HOME': '/Users/cltbld', 12:50:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:47 INFO - 'LOGNAME': 'cltbld', 12:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:47 INFO - 'MOZ_NO_REMOTE': '1', 12:50:47 INFO - 'NO_EM_RESTART': '1', 12:50:47 INFO - 'PAGER': '/bin/cat', 12:50:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:47 INFO - 'PWD': '/builds/slave/test', 12:50:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:47 INFO - 'SHELL': '/bin/bash', 12:50:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0s8nemmtfa/Listeners', 12:50:47 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 12:50:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:47 INFO - 'USER': 'cltbld', 12:50:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:47 INFO - 'XPC_FLAGS': '0x0', 12:50:47 INFO - 'XPC_SERVICE_NAME': '0', 12:50:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:47 INFO - Downloading/unpacking blobuploader==1.2.4 12:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:50 INFO - Downloading blobuploader-1.2.4.tar.gz 12:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:50:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:50:50 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 12:50:50 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 12:50:50 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 12:50:50 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 12:50:50 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 12:50:50 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 12:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:50:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:50:50 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 12:50:50 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 12:50:50 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 12:50:50 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 12:50:50 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 12:50:50 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 12:50:51 INFO - Downloading docopt-0.6.1.tar.gz 12:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:50:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:50:51 INFO - Running setup.py install for blobuploader 12:50:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:50:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:50:51 INFO - Running setup.py install for requests 12:50:52 INFO - Running setup.py install for docopt 12:50:52 INFO - Successfully installed blobuploader requests docopt 12:50:52 INFO - Cleaning up... 12:50:52 INFO - Return code: 0 12:50:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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 0x10885da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faeb35a2200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fce00>, '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 0x108565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f7b20>, '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.6R9WdPCTRF/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.0s8nemmtfa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 12:50: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 12:50: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 12:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6R9WdPCTRF/Render', 12:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:52 INFO - 'HOME': '/Users/cltbld', 12:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:52 INFO - 'LOGNAME': 'cltbld', 12:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:52 INFO - 'MOZ_NO_REMOTE': '1', 12:50:52 INFO - 'NO_EM_RESTART': '1', 12:50:52 INFO - 'PAGER': '/bin/cat', 12:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:52 INFO - 'PWD': '/builds/slave/test', 12:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:52 INFO - 'SHELL': '/bin/bash', 12:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0s8nemmtfa/Listeners', 12:50:52 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 12:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:52 INFO - 'USER': 'cltbld', 12:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:52 INFO - 'XPC_FLAGS': '0x0', 12:50:52 INFO - 'XPC_SERVICE_NAME': '0', 12:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:52 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-pLmFVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:52 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-zucxB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:52 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-vT2mp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:52 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-XOdB24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:53 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-MICy9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:53 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-8PBJU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:53 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-y6FgGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:53 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-zm8dgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:53 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-_p4i89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:53 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-dMqy2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:53 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-hE_MkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:53 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-81oPql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:50:53 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-Fdcv0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:50:53 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-2oVpzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:54 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-k6ZklK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:50:54 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-EH_XqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:50:54 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-lWCnxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:50:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:50:54 INFO - Running setup.py install for manifestparser 12:50:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:50:54 INFO - Running setup.py install for mozcrash 12:50:54 INFO - Running setup.py install for mozdebug 12:50:54 INFO - Running setup.py install for mozdevice 12:50:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:50:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:50:55 INFO - Running setup.py install for mozfile 12:50:55 INFO - Running setup.py install for mozhttpd 12:50:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:50:55 INFO - Running setup.py install for mozinfo 12:50:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:50:55 INFO - Running setup.py install for mozInstall 12:50:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:50:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:50:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:50:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:50:55 INFO - Running setup.py install for mozleak 12:50:55 INFO - Running setup.py install for mozlog 12:50:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:50:55 INFO - Running setup.py install for moznetwork 12:50:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:50:56 INFO - Running setup.py install for mozprocess 12:50:56 INFO - Running setup.py install for mozprofile 12:50:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:50:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:50:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:50:56 INFO - Running setup.py install for mozrunner 12:50:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:50:56 INFO - Running setup.py install for mozscreenshot 12:50:56 INFO - Running setup.py install for moztest 12:50:56 INFO - Running setup.py install for mozversion 12:50:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:50:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:50:56 INFO - Cleaning up... 12:50:56 INFO - Return code: 0 12:50:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:56 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 0x10885da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faeb35a2200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fce00>, '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 0x108565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f7b20>, '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.6R9WdPCTRF/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.0s8nemmtfa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 12:50:56 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 12:50:56 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 12:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6R9WdPCTRF/Render', 12:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:56 INFO - 'HOME': '/Users/cltbld', 12:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:56 INFO - 'LOGNAME': 'cltbld', 12:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:56 INFO - 'MOZ_NO_REMOTE': '1', 12:50:56 INFO - 'NO_EM_RESTART': '1', 12:50:56 INFO - 'PAGER': '/bin/cat', 12:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:56 INFO - 'PWD': '/builds/slave/test', 12:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:56 INFO - 'SHELL': '/bin/bash', 12:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0s8nemmtfa/Listeners', 12:50:56 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 12:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:56 INFO - 'USER': 'cltbld', 12:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:56 INFO - 'XPC_FLAGS': '0x0', 12:50:56 INFO - 'XPC_SERVICE_NAME': '0', 12:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:57 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-bg92DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50: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)) 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:57 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-6n3THP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:57 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)) 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:57 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-eG2odR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:57 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)) 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:57 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-J3MGyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:57 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)) 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:57 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-nqCvsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:57 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)) 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:57 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-dciOBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:57 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)) 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:57 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-6fOTrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:57 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)) 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:57 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-AdMP_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50: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)) 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:58 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-oQum0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50: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)) 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:58 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-WaCU18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50: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)) 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:58 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-ri_IBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50: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)) 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:58 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-aAtbAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:50:58 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)) 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:50:58 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-8RQG2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:50:58 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)) 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:50:58 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-UkafQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:50:58 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)) 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:58 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-WVckei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:58 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)) 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:50:58 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-NRBel1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:50:58 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)) 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:50:58 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-5ecn95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:50: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)) 12:50: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)) 12:50: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)) 12:50: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)) 12:50: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)) 12:50: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)) 12:50:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:51:01 INFO - Downloading blessings-1.6.tar.gz 12:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:01 INFO - Installing collected packages: blessings 12:51:01 INFO - Running setup.py install for blessings 12:51:01 INFO - Successfully installed blessings 12:51:01 INFO - Cleaning up... 12:51:01 INFO - Return code: 0 12:51:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:02 INFO - Reading from file tmpfile_stdout 12:51:02 INFO - Current package versions: 12:51:02 INFO - blessings == 1.6 12:51:02 INFO - blobuploader == 1.2.4 12:51:02 INFO - docopt == 0.6.1 12:51:02 INFO - manifestparser == 1.1 12:51:02 INFO - mozInstall == 1.12 12:51:02 INFO - mozcrash == 0.17 12:51:02 INFO - mozdebug == 0.1 12:51:02 INFO - mozdevice == 0.48 12:51:02 INFO - mozfile == 1.2 12:51:02 INFO - mozhttpd == 0.7 12:51:02 INFO - mozinfo == 0.9 12:51:02 INFO - mozleak == 0.1 12:51:02 INFO - mozlog == 3.1 12:51:02 INFO - moznetwork == 0.27 12:51:02 INFO - mozprocess == 0.22 12:51:02 INFO - mozprofile == 0.28 12:51:02 INFO - mozrunner == 6.11 12:51:02 INFO - mozscreenshot == 0.1 12:51:02 INFO - mozsystemmonitor == 0.0 12:51:02 INFO - moztest == 0.7 12:51:02 INFO - mozversion == 1.4 12:51:02 INFO - psutil == 3.1.1 12:51:02 INFO - requests == 1.2.3 12:51:02 INFO - wsgiref == 0.1.2 12:51:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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 0x10885da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faeb35a2200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fce00>, '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 0x108565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f7b20>, '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.6R9WdPCTRF/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.0s8nemmtfa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 12:51: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 12:51: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 12:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6R9WdPCTRF/Render', 12:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:02 INFO - 'HOME': '/Users/cltbld', 12:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:02 INFO - 'LOGNAME': 'cltbld', 12:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:02 INFO - 'MOZ_NO_REMOTE': '1', 12:51:02 INFO - 'NO_EM_RESTART': '1', 12:51:02 INFO - 'PAGER': '/bin/cat', 12:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:02 INFO - 'PWD': '/builds/slave/test', 12:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:02 INFO - 'SHELL': '/bin/bash', 12:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0s8nemmtfa/Listeners', 12:51:02 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 12:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:02 INFO - 'USER': 'cltbld', 12:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:02 INFO - 'XPC_FLAGS': '0x0', 12:51:02 INFO - 'XPC_SERVICE_NAME': '0', 12:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 INFO - Cleaning up... 12:51:02 INFO - Return code: 0 12:51:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:02 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 0x10885da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faeb35a2200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fce00>, '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 0x108565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f7b20>, '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.6R9WdPCTRF/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.0s8nemmtfa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 12:51:02 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 12:51:02 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 12:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6R9WdPCTRF/Render', 12:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:02 INFO - 'HOME': '/Users/cltbld', 12:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:02 INFO - 'LOGNAME': 'cltbld', 12:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:02 INFO - 'MOZ_NO_REMOTE': '1', 12:51:02 INFO - 'NO_EM_RESTART': '1', 12:51:02 INFO - 'PAGER': '/bin/cat', 12:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:02 INFO - 'PWD': '/builds/slave/test', 12:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:02 INFO - 'SHELL': '/bin/bash', 12:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0s8nemmtfa/Listeners', 12:51:02 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 12:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:02 INFO - 'USER': 'cltbld', 12:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:02 INFO - 'XPC_FLAGS': '0x0', 12:51:02 INFO - 'XPC_SERVICE_NAME': '0', 12:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:02 INFO - Downloading/unpacking jsonschema 12:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:51:05 INFO - Downloading/unpacking functools32 (from jsonschema) 12:51:05 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 12:51:05 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 12:51:05 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 12:51:05 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 12:51:05 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 12:51:05 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 12:51:05 INFO - Downloading functools32-3.2.3-2.tar.gz 12:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:51:05 INFO - warning: no files found matching '*.txt' 12:51:05 INFO - no previously-included directories found matching 'build' 12:51:05 INFO - no previously-included directories found matching 'dist' 12:51:05 INFO - no previously-included directories found matching '.git*' 12:51:05 INFO - Installing collected packages: jsonschema, functools32 12:51:05 INFO - Running setup.py install for functools32 12:51:05 INFO - warning: no files found matching '*.txt' 12:51:05 INFO - no previously-included directories found matching 'build' 12:51:05 INFO - no previously-included directories found matching 'dist' 12:51:05 INFO - no previously-included directories found matching '.git*' 12:51:05 INFO - Successfully installed jsonschema functools32 12:51:05 INFO - Cleaning up... 12:51:05 INFO - Return code: 0 12:51:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:05 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 0x10885da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faeb35a2200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fce00>, '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 0x108565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f7b20>, '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.6R9WdPCTRF/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.0s8nemmtfa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 12:51:05 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 12:51:05 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 12:51:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6R9WdPCTRF/Render', 12:51:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:05 INFO - 'HOME': '/Users/cltbld', 12:51:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:05 INFO - 'LOGNAME': 'cltbld', 12:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:05 INFO - 'MOZ_NO_REMOTE': '1', 12:51:05 INFO - 'NO_EM_RESTART': '1', 12:51:05 INFO - 'PAGER': '/bin/cat', 12:51:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:05 INFO - 'PWD': '/builds/slave/test', 12:51:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:05 INFO - 'SHELL': '/bin/bash', 12:51:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0s8nemmtfa/Listeners', 12:51:05 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 12:51:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:05 INFO - 'USER': 'cltbld', 12:51:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:05 INFO - 'XPC_FLAGS': '0x0', 12:51:05 INFO - 'XPC_SERVICE_NAME': '0', 12:51:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:06 INFO - Downloading/unpacking flake8 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:51:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:51:08 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 12:51:08 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 12:51:08 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 12:51:08 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 12:51:08 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 12:51:08 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 12:51:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:51:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:51:09 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 12:51:09 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 12:51:09 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 12:51:09 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 12:51:09 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 12:51:09 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 12:51:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:51:09 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 12:51:09 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 12:51:09 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 12:51:09 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 12:51:09 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 12:51:09 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 12:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:51:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:09 INFO - no previously-included directories found matching 'docs/_build' 12:51:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:51:10 INFO - Running setup.py install for pep8 12:51:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:10 INFO - no previously-included directories found matching 'docs/_build' 12:51:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:51:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:51:10 INFO - Cleaning up... 12:51:10 INFO - Return code: 0 12:51:10 INFO - Running post-action listener: _resource_record_post_action 12:51:10 INFO - Running post-action listener: _start_resource_monitoring 12:51:10 INFO - Starting resource monitoring. 12:51:10 INFO - ##### 12:51:10 INFO - ##### Running install step. 12:51:10 INFO - ##### 12:51:10 INFO - Running pre-action listener: _resource_record_pre_action 12:51:10 INFO - Running main action method: install 12:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:10 INFO - Reading from file tmpfile_stdout 12:51:10 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:10 INFO - Reading from file tmpfile_stdout 12:51:10 INFO - Output received: 12:51:10 INFO - Usage: mozinstall [options] installer 12:51:10 INFO - Options: 12:51:10 INFO - -h, --help show this help message and exit 12:51:10 INFO - -d DEST, --destination=DEST 12:51:10 INFO - Directory to install application into. [default: 12:51:10 INFO - "/builds/slave/test"] 12:51:10 INFO - --app=APP Application being installed. [default: firefox] 12:51:10 INFO - mkdir: /builds/slave/test/build/application 12:51:10 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'] 12:51:10 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 12:51:32 INFO - Reading from file tmpfile_stdout 12:51:32 INFO - Output received: 12:51:32 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:51:32 INFO - Running post-action listener: _resource_record_post_action 12:51:32 INFO - ##### 12:51:32 INFO - ##### Running run-tests step. 12:51:32 INFO - ##### 12:51:32 INFO - Running pre-action listener: _resource_record_pre_action 12:51:32 INFO - Running main action method: run_tests 12:51:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:51:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:51:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:51:32 INFO - 2016-07-26 12:51:32.376 screenresolution[1637:7496] starting screenresolution argv=screenresolution get 12:51:32 INFO - 2016-07-26 12:51:32.379 screenresolution[1637:7496] Display 0: 1600x1200x32@60 12:51:32 INFO - 2016-07-26 12:51:32.384 screenresolution[1638:7498] starting screenresolution argv=screenresolution list 12:51:32 INFO - Available Modes on Display 0 12:51:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:51:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:51:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:51:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:51:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:51:32 INFO - Intel Iris: 12:51:32 INFO - Chipset Model: Intel Iris 12:51:32 INFO - Type: GPU 12:51:32 INFO - Bus: Built-In 12:51:32 INFO - VRAM (Dynamic, Max): 1536 MB 12:51:32 INFO - Vendor: Intel (0x8086) 12:51:32 INFO - Device ID: 0x0a2e 12:51:32 INFO - Revision ID: 0x0009 12:51:32 INFO - Displays: 12:51:32 INFO - Display: 12:51:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:51:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:51:32 INFO - Display Serial Number: 1600x1200 60 12:51:32 INFO - Main Display: Yes 12:51:32 INFO - Mirror: Off 12:51:32 INFO - Online: Yes 12:51:32 INFO - Rotation: Supported 12:51:32 INFO - Return code: 0 12:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:32 INFO - Python 2.7.3 12:51:32 INFO - Return code: 0 12:51:32 INFO - grabbing minidump binary from tooltool 12:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:32 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 0x1086fce00>, '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 0x108565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:32 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 12:51:32 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 12:51:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:32 INFO - Return code: 0 12:51:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:51:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:51:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:51:33 INFO - Return code: 0 12:51:33 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/1469543878/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0230', '--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 12:51:33 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/1469543878/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0230 --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 12:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6R9WdPCTRF/Render', 12:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:33 INFO - 'HOME': '/Users/cltbld', 12:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:33 INFO - 'LOGNAME': 'cltbld', 12:51:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:33 INFO - 'MOZ_NO_REMOTE': '1', 12:51:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:33 INFO - 'NO_EM_RESTART': '1', 12:51:33 INFO - 'PAGER': '/bin/cat', 12:51:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:33 INFO - 'PWD': '/builds/slave/test', 12:51:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:33 INFO - 'SHELL': '/bin/bash', 12:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0s8nemmtfa/Listeners', 12:51:33 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 12:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:33 INFO - 'USER': 'cltbld', 12:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:33 INFO - 'XPC_FLAGS': '0x0', 12:51:33 INFO - 'XPC_SERVICE_NAME': '0', 12:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:33 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/1469543878/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0230', '--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 12:51:34 INFO - mozversion application_buildid: 20160726073758 12:51:34 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 12:51:34 INFO - mozversion application_display_name: Firefox 12:51:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:34 INFO - mozversion application_name: Firefox 12:51:34 INFO - mozversion application_remotingname: firefox 12:51:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:51:34 INFO - mozversion application_vendor: Mozilla 12:51:34 INFO - mozversion application_version: 48.0 12:51:34 INFO - mozversion platform_buildid: 20160726073758 12:51:34 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 12:51:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:51:34 INFO - mozversion platform_version: 48.0 12:51:34 INFO - using testdate: 1469562694 12:51:34 INFO - actual date: 1469562694 12:51:34 INFO - starting webserver on 'localhost:49264' 12:51:34 INFO - SUITE-START | Running 2 tests 12:51:34 INFO - TEST-START | dromaeo_css 12:51:34 INFO - operating with platform_type : mac_ 12:51:34 INFO - Initialising browser for dromaeo_css test... 12:51:34 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/tmpsttdJe/profile http://localhost:49264/getInfo.html) 12:51:36 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 12:51:36 INFO - PROCESS | 1656 | colorDepth:24 12:51:36 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 12:51:36 INFO - PROCESS | 1656 | __metrics 12:51:36 INFO - PROCESS | 1656 | 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" 12:51:36 ERROR - PROCESS | 1656 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:51:37 INFO - TEST-INFO | 1656: exit 0 12:51:37 INFO - Browser initialized. 12:51:37 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:37 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/tmpsttdJe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:48 INFO - PROCESS | 1662 | RSS: Main: 160198656 12:51:48 INFO - PROCESS | 1662 | 12:52:40 INFO - PROCESS | 1662 | 1469562760280 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] 12:54:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 12:54:52 INFO - PROCESS | 1662 | RSS: Main: 338173952 12:54:52 INFO - PROCESS | 1662 | 12:57:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 12:57:55 INFO - PROCESS | 1662 | RSS: Main: 305262592 12:57:55 INFO - PROCESS | 1662 | 13:00:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 13:00:58 INFO - PROCESS | 1662 | RSS: Main: 308883456 13:00:58 INFO - PROCESS | 1662 | 13:04:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 13:04:01 INFO - PROCESS | 1662 | RSS: Main: 307257344 13:04:01 INFO - PROCESS | 1662 | 13:07:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 13:07:04 INFO - PROCESS | 1662 | RSS: Main: 279207936 13:07:04 INFO - PROCESS | 1662 | 13:10:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 13:10:07 INFO - PROCESS | 1662 | RSS: Main: 314204160 13:10:07 INFO - PROCESS | 1662 | 13:10:07 INFO - PROCESS | 1662 | __start_tp_report 13:10:07 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 13:10:07 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 13:10:07 INFO - PROCESS | 1662 | |i|pagename|runs| 13:10:07 INFO - PROCESS | 1662 | |0;dojo.html;3503.246801937583;3511.9122021949465;3530.752847300689;3577.2308953574975;3579.2304654499294;5847.4152584741505;5901.439363260489;5921.85195370116;5926.881462370756;5957.791477298296;5893.204417403649;5962.672053037081;5965.761369545213;5971.880562388749;5980.282366116061;5266.394364648077;5357.062514060033;5420.268263784398;5436.293281873351;5498.972505137469;5424.5117939385445;5473.370562385317;5473.781048758045;5477.260569823063;5483.067878460652;5404.83785486434;5438.401775804678;5439.265699130626;5469.206964990074;5470.316210473691;5459.617826752109;5498.257735205736;5500.4224556421395;5513.228148059275;5521.668699878021;5275.235090911835;5288.497592728723;5351.812686555952;5360.624756267063;5397.649152805055;5739.110437882135;5778.104393818965;5788.942110578882;5795.478406943354;5806.361300256968;6265.906011409833;6285.528585356116;6300.810975670737;6313.684315784239;6320.336364681734;6186;6240.687965601747;6328.335524769925;6334.5249106317215;6339.904901426482;5367.06076436626;5770.307563092414;5990.191324171268;5998.190244317048;6088.512918966472;6488.902666460007;6520.315366886503;6522;6522.249941256721;6532.869342613121;6153.29237137726;6168.814935551941;6184.783532576338;6250.437460628475;6388.5528013039575;6293.2762732285455;6298.7480500780375;6299.118123462719;6319.083732858801;6320.336364681734;5386.703731294817;6200.821843849654;6311.96844015777;6317.526185536103;6332.968335158294;6252.468540174045;6278.560500764903;6340.746370145235;6347.1114044033875;6349.07938348946;4996.7001979881325;5069.543741063322;5098.439171691111;5108.3103780989095;5133.178691409431;4559.179347717376;4568.291914753218;4580.427446569179;4590.40324757786;4612.95387046132;5870.232244867397;5900.970495147497;5957.940420595825;6096.8780624388155;6104.938950610437;6195.845103872349;6259.029850373199;6337.7781777637565;6340.651264180422;6347.650879201596;6013.188219590387;6067.150598916155;6102.359252278536;6124.479419249325;6139.386061393825;5579.358373787067;5589.189567512688;5608.46719561641;5615.466530679579;5626.578006649518;6416.903746443807;6456.677166141768;6470.255920569007;6500.284968653539;6595.175603049619;6282.780102696383;6292.182016337847;6336.20797400325;6344.270408903035;6361.395667411589;6566.573172743756;6587.242467116343;6620.205575330799;6637.2699003108655;6654.13496245485;6274.6548939808745;6293.307736149111;6312.779052733133;6330.968345158429;6370.362963703593;6218.5647004711045;6240.438360547572;6290.9056364155485;6295.433410993032;6307.936920630918;5243.790248390174;6043.425874541911;6270.404311590391;6310.716017779119;6328.0824280478155;6306.369363063657;6309.810705678837;6313.2424109107205;6331.96834015827;6361.650109244036;6074.453299203093;6140.074827791203;6211.81364559064;6213.96893015532;6219.440250377488;6288.339724328879;6311.936880631135;6334.6832658365975;6337.968310158604;6353.5870168438905;6052.636841789331;6137.931034482759;6145.231846019247;6209.192804935329;6232.345603711727 13:10:07 INFO - PROCESS | 1662 | |1;ext.html;532.3797775591435;554.836323284631;586.6157666728294;598.5421152818092;628.6039794929194;26650;32501.51247731283;39281.60718392819;39540.406893896616;40077.398839017435;42841.78579107108;43166;43350.56649433505;43360;43479.78260108703;9628.951855240713;9810.70567882961;9811.067948544913;9821.2634052446;9824.803503929917;9190.816183676323;11986.400679966011;12280.324582147978;12291.262524248528;12292.877071229263;11974;12068.336241506713;12071.758564828699;12072.094592905567;12082.51669933206;11897.583584574542;11988.700282492964;11989.820152697717;11995.340256285901;12000.69998250042;11670.941645291805;11762.941185294105;11766.58816941403;11806.291622502677;11824.645260642195;39642.61250856235;39908.20183596312;40000.999975000566;40015.59984400177;40084;3274.7707660463775;3288.2765791525826;3294.1929227339215;3383.1203886989315;3400.0819778659625;27430.314242144104;27441.31396715078;27606;27731.722682773318;28439.431211375657;2742.3966727319957;2762.047093752652;2783.7912156588336;2784.610154578361;2842.9431411371866;322970;325608.7439125602;327265;327935;328250;37799.05502362408;38468.42297365542;38496.230075398336;38543.145685431795;59744.40255597388;37436.25127497489;37546.81226593904;37560;37638.24723505515;37706.81146594304;15672.216389180496;15811.762823557656;15822.60443488899;15884.76172857408;15920.363185472452;12492.25046497213;12549.058820588492;12583.245005299712;13194.142380745412;13239.867601323864;7972.880406793903;8615;8637.69768058115;8699.652013919498;8730.17063378978;3495.598006229265;3588.4617307404096;3599.208174201724;3612.8735494257576;3625.9456108158397;1005.3063386263455;1039.5114296280735;1046.549983507084;1074.3768614203743;1122.3669560789033;30761.538576921364;30955.226119346746;31018;31481.527777083364;31714.524282135786;973.1873885305707;1124.960626378073;1144.2676686920377;1255.7300180461061;1261.148724610884;15758.369665213493;15855.762163567555;15928.964617299838;16067.839321606869;16191.757123643154;588608;595958.0202098961;596786;597365;598762;63393;64100;64145.67927160428;64224;64275.678621606596;1439.330711219288;1451.985480145206;1484.3691431141722;1561.4534912780437;1566.2560283865073;28288.00991965271;28640.283992900346;29839.403211935205;29958.850205748833;30538.389232215675;45149.54850451453;49347.50652493429;49379;49429.25856112233;49486.75256623694;391035.044824774;402751;403055;404435;578410;27683.72316276892;28338.858305708338;28672.856635717522;43423.13153736971;44682;46563.76718116388;46938.530614693416;47439.52560474351;47601.76199118982;48323.275150873465;37807.43288850615;37843.432348514245;38798;38839.6116038836;39438;37805.8886370672;38349;38636;39140.2171956565;39185.608143918194;38990;39217;39469;40834.97912552091;40909.590904090575;33040.83479582587;33563;34417.65582344145;34511.13722156966;34532;25845;25893.352666183495;25935.740642594086;26101;26275.21174364772 13:10:07 INFO - PROCESS | 1662 | |2;jquery.html;410.95890410958907;411.84349947020127;419.84255904035984;422.3938648040062;427.211794239628;20543.486412839688;21245.468863278427;21259.04334304958;21561.46096347592;22608;12225.755484890318;12552.497900083985;17098.401555945544;22028.229011984582;22099.889500552516;5044.268581055745;5232.189010703328;5305.779670675727;6289.119523266723;6313.337099604544;6234.314225435199;6245.812625621216;6288.371162883721;6288.496920246369;6292;6071.757129714828;6211.534134939875;6240.719167637467;6244;6270.122182894398;6186.628802271855;6226.0349645804745;6230.470410015154;6233.937660623381;6251.406116418956;5554.72226388679;5757.510611598019;6066.029435290377;6066.454019138255;6077.4226448487325;14134.293285335794;14153.150810951272;14177.929110354486;22212.778297193647;26274.73725262742;2347.906083756665;2500.1624455807328;2544.440223150904;2741.7121202273674;2882.538793792983;9915.80168396628;10144.644937427229;10512.948705129502;10859.40273284969;14940.95413321068;1747.615524584602;1824.917878695462;1841.4107485604611;1923.3268356075403;1958.1677786940636;69082.3091769081;87984;114363;120969.99999999913;125772;11920.403979800974;11990.460429280703;11992.820107698391;12009.399530023464;12018.33899135556;14112.364943577564;14567.198804065667;15074.246287685572;15625;15878.364865405254;8082.2725954664365;8332.33341332692;8905.599248033854;8981.595828187747;9099.226565741987;8966.551672416354;8994.730158095268;9002.279817614575;9041.638334466548;9130.406523575946;4816.253480710496;4826.155422800995;4827.806887724522;4854.514548545118;4861.270809378621;1668.5828542864283;2012.788657190974;2029.5433527456205;2036;2039.4697378681353;920.2408013388981;978.3738407419257;990.6829814459448;1021.9693409197736;1075.8224892892742;20232.096350918542;20733.27433539819;20888.686669699968;20894.47763805917;20896.47758806042;981.5239608789731;1055.7096798380353;1067.3435836960214;1093.4314156638504;1104.4643347976225;10618.681439556825;10984.505697243643;11019.283746556608;11072.723181920517;11084.334939903632;576305.2369476336;646178;660004;667051;670032;129530;133313.3334333322;133582.99999999805;135319;137061.3146934259;954.9665761698308;978.8678528398717;983.8081574092984;984.0405604535521;987.8518222266574;18283.54291142732;18460;18514.814851851308;18543.443696689123;18640.440786776417;37172.62827371692;52250.21624675709;52926.41220763229;53581.66045848885;55228;71402.64298678473;71617;71803.64098179476;72996;77846.22153778616;8140.226678465537;8384.748457546284;8396.580170991549;8580.013298470756;8607.268382187583;11868.643940681794;12940.805887911878;13084.28036458004;13088;13354.599362019155;9578.329516933747;11280.2667826591;11299.548018079186;11552.537898483966;11595.594154204562;10969.945150274198;11000.724981875197;11182.496787644413;11418.31490110596;11624.953754161828;11297;11565.768684626428;11861.76276474483;11884.881151188723;11921.761564768829;8279.751607451786;8333.166683331861;8491.74524764258;8545.273651739422;8742.650293988168;10988.945055274673;11188.272762270426;11231.101511879193;11410.885891141314;11519.19365644397 13:10:07 INFO - PROCESS | 1662 | |3;mootools.html;1437.7412065828146;1631.7307644238701;1654.3961454069265;1930.4787707319024;2032.126185740132;8195.467294625845;8792.98880628728;8906.732798016053;8911;8919.509426981513;8596.097409771977;8864.069272726367;8871.55642217888;8873.68942087027;8877.201051905327;2516.7860731837814;2542.148380292604;2547.5541780188487;2547.923562293134;2550.1966880432697;2485.8384205026705;2562.782163516094;2565.884535195911;2565.9230223093246;2570.408805974627;2526.633638122471;2553.834000789952;2570.884310206045;2574.4207553300544;2574.588065909455;2045.7647370552354;2518.320053585531;2551.795856331489;2562.1416825363526;2571.8199726018997;2509.5859183234743;2534.809889258295;2541.0852093246417;2543;2553.259554729126;8787.64849406023;8895.976962649249;8924.152205540464;8948.507832069234;8990.41562298455;5585.385607583204;5684.289463817023;5685.516731077863;5725.627834190765;5733.283339582552;3384.8984530464127;3558.768680035789;3628.8911332660064;3709.8516059357594;3761.4733937248807;1069.8716154061485;1072.3030030480172;1087.494315143462;1103.5254840418618;1104.7072525780675;12085.697857553543;12169.634910952685;12171.93914030433;12207.084468664885;12216.328101954388;4666.533346665306;4737.857864264078;4745.383100197021;4797.7601119943865;4808.206645903457;9498.430094194371;9499.192568631745;9501.857472137923;9511.191548718298;9521.143097121292;5425.6202065855805;5425.810096646598;5434.266374039533;5437.102878025082;5441.537469315073;3786.7159963002887;4688.179568575554;4939.90120197594;5089.872753181126;5100.0819852426175;3958;3982.38273067675;4031.5162180537936;4071.063655359225;4071.714979951434;1269.8920591749804;1273.7134144817342;1274.216356940475;1283.9871601284055;1289.6775806048488;951.5432592355708;966.9419834809934;971.8736564246602;981.5582987655583;1011.6459239266198;6085.908711369245;6087.3303936566945;6092.8781424372155;6224.782132625427;6249.937500625027;475.32029198246147;489.3589397888777;495.20766773162654;498.8029728257318;499.7501249375312;3743.8689645862264;3784.6215378461934;3854.1713531590844;3859.9614003860165;3872.0513474199;10631.46842657864;11096.722581935515;11112.611058612909;11114.388708620942;11124.443777811239;10839.187060970458;10970.067544258667;10974;10975.792662807085;11011.779764404668;8400.781886626404;8604.225619694258;8607.311415086779;8614.569271536398;8642.827143457096;5297.682139071668;5603.10350343943;5667.489925906523;6013.188219590299;6059.6364218147055;9638.614455421985;9809.41143531362;9981;10005.849912251468;10032.749181270234;8043.798905027421;9962.501874906371;9995.250356223167;10175.338602990782;10211.489425528842;5706.629069110494;6746.460283177236;6969.919662452328;7171.605561693948;7178.60517671533;8474.237318641352;8491.830163396575;8555.743327700178;8555.743327700178;8570.828583428422;7431.331180193809;7573.886391704239;7657.510193149023;7659.693612255447;7695.192004839635;7471.6637751302405;7484.251574842472;7506.136794268729;7611.923880761122;7638.885416718865;7195.604241766753;7251.41988640918;7255.600941948243;7271.272872712686;7272.127344718456;4782.641301902441;4828.179209534317;4965.255211718127;5003.149464590955;5033.5721463676;4960.900781984412;5004.84985450437;5026.421961474477;5050.9747451263975;5088.338515993045 13:10:07 INFO - PROCESS | 1662 | |4;prototype.html;331.2844256406163;337.16887871397;340.9846556904939;344.57617130928975;346.0017848507058;6547.901781473276;6550.279469258384;6590.275069742324;6591.110200122982;6592.340765923417;6537.313582073885;6547.544670748469;6559.048937904001;6588.967055164718;6590.934090659092;4672.813087476506;4781.832635857746;4790.5448982346625;4900.387451568554;4918.975405122969;4885.340479035321;4971.651984361096;4977.527134922195;4988.251762235657;5021.372328458942;4896.338994235768;4905.068037072945;4909.582685471739;4925.26121081837;4931.580815630676;4658.161530924433;4719.43366795985;4861.076395484882;4862.124817532843;4877.439094504142;4170.249355116078;4212.073343864376;4225.598568136053;4228.112096459748;4247.851325203603;6254.655993920333;6290.276618188921;6300.401461861115;6301.369863013708;6326.145970293997;5736.684482353469;5737.2254745609225;5748.655080695172;5753.741081651336;5760.279965004374;6773.4242589379965;6971.407430368425;7020.29797020299;7020.5787652741;7035.33164349386;4689.671722979393;4704.223803072489;4707.857924644313;4740.217864052427;4743.596794272491;5619.269494965628;6277.937220627781;7090.822729431754;7327.377172940306;7432.628368581603;4766.713997160112;4776.8566942991765;4796.496367881392;4798.160321943646;4804.015176888729;4836.661433699607;4860.9513904861205;4872.829450969199;4873.049755297683;4885.2427873679635;4625.629949604024;5707.885842283131;5726.255586773693;5763;5769.249997500298;6737.59574425536;6984.2317345092;7021.438284937193;7029.789106326818;7087.220405755363;1673.564873132994;1683.6380178261732;1697.6944150052861;1698.8471037606428;1707.1976171199517;1023.7389465686202;1038.4496217004998;1082.7293176705823;1083.7778255457613;1103.9834402483968;6579.868402631921;6827.52207345481;6832.248452670202;6841.965790171117;6868.141482314711;6742.089817874622;7348.522346047596;7372.668229929666;7403.5928023959195;7415.925840741524;5511.503964643121;6072.72472780721;6746.460283177334;6749.797506074826;6810.353016463428;3479.112826229346;3743.6256374362347;3847.1728578355787;3867.5358956925347;3867.7292589518465;6771.492138089565;6973.81445154325;7719.228077192236;7734.342580880576;7769.79568166935;6325.8929687304535;7476.327130558276;7523.28528789775;7624.046994125734;7630.236976302436;7726.304632583095;7750;7750.883736743841;7793.7272195474025;7793.766187014398;6997.230304666381;7035.8039133348475;7040.753573625104;7364.815879603053;7369.410447164321;7175.497715159889;7208.098987626547;7223.494355395282;7224.458165637703;7235.493515453868;7709.691612335444;7722.38220942312;7730;7734.845303093794;7740.225977402215;4641.953580464287;4707.105649926503;4710.128626204163;4715.363425937455;4716;6998.725414240291;7354.896765485006;7370.115586129485;7372.004779354718;7379.8155046124275;7074.858502830018;7124.715011399693;7130.928690713026;7139.82150446243;7147.85704285901;7114.6442677866935;7120.821979450555;7136.324792731851;7139.428845692229;7143.071400718081;6966.233714291525;6968.616726080114;6982.68577913985;6984.615846128511;6992.0910281663055;5711.914321285101;6870.175578930561;7102.928970710227;7115.395191408788;7117.43060555144;6596.505262105457;6765.627890466071;6773.390394864486;6803.353681400259;6959.478039147186 13:10:07 INFO - PROCESS | 1662 | |5;yui.html;712.1240873725321;763.2672634271099;765.7281665008921;780.0717146595551;824.5877061469264;15328.770068448983;15478.226088695563;15517.224138793043;15532.223388830556;17695.380661676845;16194.514164575052;16264.83735162648;16265.91867040663;16281.674366512692;16353.591160221;774.5623722596742;964.161179773598;977.3891317926297;985.4579981010452;985.6402413119196;794.5749024272016;952.4666186935339;987.6641941739807;988.2785566536432;989.3074847606669;1034.7930413917209;1037.6783197208852;1038.3717850700332;1039.2361614213546;1041.7031146123356;756.587659725451;769.1385648074137;1026.194437366671;1027.2552399510332;1027.881793593735;736.7237286017744;762.1121393576477;763.1300317637897;763.3511515212081;764.1785081037907;12673;15371.538853834403;15551.844481555152;15570.766438503319;15610.375584976588;12958;13084;13238.86761132386;13262.8222110036;13457.192568445924;9978.501074946296;10092.293539452241;10094.848577271347;10127.746806329827;10165.542550585242;3560.2345495718287;3582.3551760683067;3589.335972845006;3590.1922067534856;3640.1263696712863;81690.59154704248;82899.5855020727;83126.58436707838;83781.16218837794;83910.58044709798;9836.803263934824;9849.45827979468;9864;10290.485475726184;11038.061764749926;22933.853307334568;23143.421414464436;23150.42123946881;23204.419889502897;23208.071677132724;7563.092428908456;7753.147153813076;7932.762017139495;7977.401694872908;8055.234752698484;3502.8073455960166;4168.499780026355;4221.155768846182;4224.598663126998;4388.758618276025;3602.7117830574016;3748.5126933498473;3817.3128836809087;3837.57786643469;3840.6543411093135;692.4979389942251;697.9581225126509;706.1067749297143;710.6304721544872;712.8431745016192;566.7336351914594;571.223136534313;571.6541492397123;592.3987153039668;602.4788557897388;7788.415868809862;7872.094709108412;8813.294936405073;8918.286537077149;9179.403338782959;582.3710392775791;586.8444862111544;615.53527087049;639.4979940746491;647.3364801078837;3813.790241536742;4004.8798536043964;4058.4723985882238;4062.7968601569805;4187.895302617398;98380.52429213567;99421;99934.00065999392;100380.99238015345;101037.49481252547;76322;78853.60573197211;79140.41719165584;82075;83678.58160709158;49128;67089.6582068356;68389.97415038779;68797.65601171962;73489.63255183797;7867.763967080997;7973.441859070042;7987.880181797162;8213.301869341172;8219.876701849358;35775.284494309446;49636.751816240685;50313;50650;50882.23676644779;52645.68385790386;65509;68181.65909170422;69379;70144;11006.449677516252;11256.043236324676;11271.549138034386;11369.602063927723;11586.536538538365;9673.806523869624;11650.186641251701;11880.346580937785;12028.27830330183;12576.811347829973;11364.374959377314;11518.078553715515;11776.234544754563;11782;12021.639350819489;11629.434300213807;11650.475728592402;11716.589919352782;12151.513939442324;12164.635060948185;11798.646040618794;11895.464704088165;11922.105842062054;11933.761324773282;11936.701582460508;8468.66125354979;9834;9918.37979137624;10133.290669653348;10151.98480151979;9319.6272149116;9578.66474673411;9823.705288841345;9832.508374581099;9844.852327215242 13:10:07 INFO - PROCESS | 1662 | __end_tp_report 13:10:07 INFO - PROCESS | 1662 | __start_cc_report 13:10:07 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1654 13:10:07 INFO - PROCESS | 1662 | __end_cc_report 13:10:07 INFO - PROCESS | 1662 | __startTimestamp1469563807657__endTimestamp 13:10:07 INFO - PROCESS | 1662 | 13:10:07 INFO - PROCESS | 1662 | ------- Summary: start ------- 13:10:07 INFO - PROCESS | 1662 | Number of tests: 6 13:10:07 INFO - PROCESS | 1662 | 13:10:07 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5905.97 Median:6145.23 stddev:626.70 (10.2%) stddev-sans-first:599.61 13:10:07 INFO - PROCESS | 1662 | Values: 3503.2 3511.9 3530.8 3577.2 3579.2 5847.4 5901.4 5921.9 5926.9 5957.8 5893.2 5962.7 5965.8 5971.9 5980.3 5266.4 5357.1 5420.3 5436.3 5499.0 5424.5 5473.4 5473.8 5477.3 5483.1 5404.8 5438.4 5439.3 5469.2 5470.3 5459.6 5498.3 5500.4 5513.2 5521.7 5275.2 5288.5 5351.8 5360.6 5397.6 5739.1 5778.1 5788.9 5795.5 5806.4 6265.9 6285.5 6300.8 6313.7 6320.3 6186.0 6240.7 6328.3 6334.5 6339.9 5367.1 5770.3 5990.2 5998.2 6088.5 6488.9 6520.3 6522.0 6522.2 6532.9 6153.3 6168.8 6184.8 6250.4 6388.6 6293.3 6298.7 6299.1 6319.1 6320.3 5386.7 6200.8 6312.0 6317.5 6333.0 6252.5 6278.6 6340.7 6347.1 6349.1 4996.7 5069.5 5098.4 5108.3 5133.2 4559.2 4568.3 4580.4 4590.4 4613.0 5870.2 5901.0 5957.9 6096.9 6104.9 6195.8 6259.0 6337.8 6340.7 6347.7 6013.2 6067.2 6102.4 6124.5 6139.4 5579.4 5589.2 5608.5 5615.5 5626.6 6416.9 6456.7 6470.3 6500.3 6595.2 6282.8 6292.2 6336.2 6344.3 6361.4 6566.6 6587.2 6620.2 6637.3 6654.1 6274.7 6293.3 6312.8 6331.0 6370.4 6218.6 6240.4 6290.9 6295.4 6307.9 5243.8 6043.4 6270.4 6310.7 6328.1 6306.4 6309.8 6313.2 6332.0 6361.7 6074.5 6140.1 6211.8 6214.0 6219.4 6288.3 6311.9 6334.7 6338.0 6353.6 6052.6 6137.9 6145.2 6209.2 6232.3 13:10:07 INFO - PROCESS | 1662 | 13:10:07 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:59474.02 Median:34464.40 stddev:124784.31 (362.1%) stddev-sans-first:125055.89 13:10:07 INFO - PROCESS | 1662 | Values: 532.4 554.8 586.6 598.5 628.6 26650.0 32501.5 39281.6 39540.4 40077.4 42841.8 43166.0 43350.6 43360.0 43479.8 9629.0 9810.7 9811.1 9821.3 9824.8 9190.8 11986.4 12280.3 12291.3 12292.9 11974.0 12068.3 12071.8 12072.1 12082.5 11897.6 11988.7 11989.8 11995.3 12000.7 11670.9 11762.9 11766.6 11806.3 11824.6 39642.6 39908.2 40001.0 40015.6 40084.0 3274.8 3288.3 3294.2 3383.1 3400.1 27430.3 27441.3 27606.0 27731.7 28439.4 2742.4 2762.0 2783.8 2784.6 2842.9 322970.0 325608.7 327265.0 327935.0 328250.0 37799.1 38468.4 38496.2 38543.1 59744.4 37436.3 37546.8 37560.0 37638.2 37706.8 15672.2 15811.8 15822.6 15884.8 15920.4 12492.3 12549.1 12583.2 13194.1 13239.9 7972.9 8615.0 8637.7 8699.7 8730.2 3495.6 3588.5 3599.2 3612.9 3625.9 1005.3 1039.5 1046.5 1074.4 1122.4 30761.5 30955.2 31018.0 31481.5 31714.5 973.2 1125.0 1144.3 1255.7 1261.1 15758.4 15855.8 15929.0 16067.8 16191.8 588608.0 595958.0 596786.0 597365.0 598762.0 63393.0 64100.0 64145.7 64224.0 64275.7 1439.3 1452.0 1484.4 1561.5 1566.3 28288.0 28640.3 29839.4 29958.9 30538.4 45149.5 49347.5 49379.0 49429.3 49486.8 391035.0 402751.0 403055.0 404435.0 578410.0 27683.7 28338.9 28672.9 43423.1 44682.0 46563.8 46938.5 47439.5 47601.8 48323.3 37807.4 37843.4 38798.0 38839.6 39438.0 37805.9 38349.0 38636.0 39140.2 39185.6 38990.0 39217.0 39469.0 40835.0 40909.6 33040.8 33563.0 34417.7 34511.1 34532.0 25845.0 25893.4 25935.7 26101.0 26275.2 13:10:07 INFO - PROCESS | 1662 | 13:10:07 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:35769.46 Median:12477.95 stddev:107085.85 (858.2%) stddev-sans-first:107353.34 13:10:07 INFO - PROCESS | 1662 | Values: 411.0 411.8 419.8 422.4 427.2 20543.5 21245.5 21259.0 21561.5 22608.0 12225.8 12552.5 17098.4 22028.2 22099.9 5044.3 5232.2 5305.8 6289.1 6313.3 6234.3 6245.8 6288.4 6288.5 6292.0 6071.8 6211.5 6240.7 6244.0 6270.1 6186.6 6226.0 6230.5 6233.9 6251.4 5554.7 5757.5 6066.0 6066.5 6077.4 14134.3 14153.2 14177.9 22212.8 26274.7 2347.9 2500.2 2544.4 2741.7 2882.5 9915.8 10144.6 10512.9 10859.4 14941.0 1747.6 1824.9 1841.4 1923.3 1958.2 69082.3 87984.0 114363.0 120970.0 125772.0 11920.4 11990.5 11992.8 12009.4 12018.3 14112.4 14567.2 15074.2 15625.0 15878.4 8082.3 8332.3 8905.6 8981.6 9099.2 8966.6 8994.7 9002.3 9041.6 9130.4 4816.3 4826.2 4827.8 4854.5 4861.3 1668.6 2012.8 2029.5 2036.0 2039.5 920.2 978.4 990.7 1022.0 1075.8 20232.1 20733.3 20888.7 20894.5 20896.5 981.5 1055.7 1067.3 1093.4 1104.5 10618.7 10984.5 11019.3 11072.7 11084.3 576305.2 646178.0 660004.0 667051.0 670032.0 129530.0 133313.3 133583.0 135319.0 137061.3 955.0 978.9 983.8 984.0 987.9 18283.5 18460.0 18514.8 18543.4 18640.4 37172.6 52250.2 52926.4 53581.7 55228.0 71402.6 71617.0 71803.6 72996.0 77846.2 8140.2 8384.7 8396.6 8580.0 8607.3 11868.6 12940.8 13084.3 13088.0 13354.6 9578.3 11280.3 11299.5 11552.5 11595.6 10969.9 11000.7 11182.5 11418.3 11625.0 11297.0 11565.8 11861.8 11884.9 11921.8 8279.8 8333.2 8491.7 8545.3 8742.7 10988.9 11188.3 11231.1 11410.9 11519.2 13:10:07 INFO - PROCESS | 1662 | 13:10:07 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5778.31 Median:499.28 stddev:3229.13 (646.8%) stddev-sans-first:3221.71 13:10:07 INFO - PROCESS | 1662 | Values: 1437.7 1631.7 1654.4 1930.5 2032.1 8195.5 8793.0 8906.7 8911.0 8919.5 8596.1 8864.1 8871.6 8873.7 8877.2 2516.8 2542.1 2547.6 2547.9 2550.2 2485.8 2562.8 2565.9 2565.9 2570.4 2526.6 2553.8 2570.9 2574.4 2574.6 2045.8 2518.3 2551.8 2562.1 2571.8 2509.6 2534.8 2541.1 2543.0 2553.3 8787.6 8896.0 8924.2 8948.5 8990.4 5585.4 5684.3 5685.5 5725.6 5733.3 3384.9 3558.8 3628.9 3709.9 3761.5 1069.9 1072.3 1087.5 1103.5 1104.7 12085.7 12169.6 12171.9 12207.1 12216.3 4666.5 4737.9 4745.4 4797.8 4808.2 9498.4 9499.2 9501.9 9511.2 9521.1 5425.6 5425.8 5434.3 5437.1 5441.5 3786.7 4688.2 4939.9 5089.9 5100.1 3958.0 3982.4 4031.5 4071.1 4071.7 1269.9 1273.7 1274.2 1284.0 1289.7 951.5 966.9 971.9 981.6 1011.6 6085.9 6087.3 6092.9 6224.8 6249.9 475.3 489.4 495.2 498.8 499.8 3743.9 3784.6 3854.2 3860.0 3872.1 10631.5 11096.7 11112.6 11114.4 11124.4 10839.2 10970.1 10974.0 10975.8 11011.8 8400.8 8604.2 8607.3 8614.6 8642.8 5297.7 5603.1 5667.5 6013.2 6059.6 9638.6 9809.4 9981.0 10005.8 10032.7 8043.8 9962.5 9995.3 10175.3 10211.5 5706.6 6746.5 6969.9 7171.6 7178.6 8474.2 8491.8 8555.7 8555.7 8570.8 7431.3 7573.9 7657.5 7659.7 7695.2 7471.7 7484.3 7506.1 7611.9 7638.9 7195.6 7251.4 7255.6 7271.3 7272.1 4782.6 4828.2 4965.3 5003.1 5033.6 4960.9 5004.8 5026.4 5051.0 5088.3 13:10:07 INFO - PROCESS | 1662 | 13:10:07 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5780.93 Median:6569.46 stddev:1825.36 (27.8%) stddev-sans-first:1784.06 13:10:07 INFO - PROCESS | 1662 | Values: 331.3 337.2 341.0 344.6 346.0 6547.9 6550.3 6590.3 6591.1 6592.3 6537.3 6547.5 6559.0 6589.0 6590.9 4672.8 4781.8 4790.5 4900.4 4919.0 4885.3 4971.7 4977.5 4988.3 5021.4 4896.3 4905.1 4909.6 4925.3 4931.6 4658.2 4719.4 4861.1 4862.1 4877.4 4170.2 4212.1 4225.6 4228.1 4247.9 6254.7 6290.3 6300.4 6301.4 6326.1 5736.7 5737.2 5748.7 5753.7 5760.3 6773.4 6971.4 7020.3 7020.6 7035.3 4689.7 4704.2 4707.9 4740.2 4743.6 5619.3 6277.9 7090.8 7327.4 7432.6 4766.7 4776.9 4796.5 4798.2 4804.0 4836.7 4861.0 4872.8 4873.0 4885.2 4625.6 5707.9 5726.3 5763.0 5769.2 6737.6 6984.2 7021.4 7029.8 7087.2 1673.6 1683.6 1697.7 1698.8 1707.2 1023.7 1038.4 1082.7 1083.8 1104.0 6579.9 6827.5 6832.2 6842.0 6868.1 6742.1 7348.5 7372.7 7403.6 7415.9 5511.5 6072.7 6746.5 6749.8 6810.4 3479.1 3743.6 3847.2 3867.5 3867.7 6771.5 6973.8 7719.2 7734.3 7769.8 6325.9 7476.3 7523.3 7624.0 7630.2 7726.3 7750.0 7750.9 7793.7 7793.8 6997.2 7035.8 7040.8 7364.8 7369.4 7175.5 7208.1 7223.5 7224.5 7235.5 7709.7 7722.4 7730.0 7734.8 7740.2 4642.0 4707.1 4710.1 4715.4 4716.0 6998.7 7354.9 7370.1 7372.0 7379.8 7074.9 7124.7 7130.9 7139.8 7147.9 7114.6 7120.8 7136.3 7139.4 7143.1 6966.2 6968.6 6982.7 6984.6 6992.1 5711.9 6870.2 7102.9 7115.4 7117.4 6596.5 6765.6 6773.4 6803.4 6959.5 13:10:07 INFO - PROCESS | 1662 | 13:10:07 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18598.15 Median:50481.50 stddev:26182.16 (51.9%) stddev-sans-first:26221.17 13:10:07 INFO - PROCESS | 1662 | Values: 712.1 763.3 765.7 780.1 824.6 15328.8 15478.2 15517.2 15532.2 17695.4 16194.5 16264.8 16265.9 16281.7 16353.6 774.6 964.2 977.4 985.5 985.6 794.6 952.5 987.7 988.3 989.3 1034.8 1037.7 1038.4 1039.2 1041.7 756.6 769.1 1026.2 1027.3 1027.9 736.7 762.1 763.1 763.4 764.2 12673.0 15371.5 15551.8 15570.8 15610.4 12958.0 13084.0 13238.9 13262.8 13457.2 9978.5 10092.3 10094.8 10127.7 10165.5 3560.2 3582.4 3589.3 3590.2 3640.1 81690.6 82899.6 83126.6 83781.2 83910.6 9836.8 9849.5 9864.0 10290.5 11038.1 22933.9 23143.4 23150.4 23204.4 23208.1 7563.1 7753.1 7932.8 7977.4 8055.2 3502.8 4168.5 4221.2 4224.6 4388.8 3602.7 3748.5 3817.3 3837.6 3840.7 692.5 698.0 706.1 710.6 712.8 566.7 571.2 571.7 592.4 602.5 7788.4 7872.1 8813.3 8918.3 9179.4 582.4 586.8 615.5 639.5 647.3 3813.8 4004.9 4058.5 4062.8 4187.9 98380.5 99421.0 99934.0 100381.0 101037.5 76322.0 78853.6 79140.4 82075.0 83678.6 49128.0 67089.7 68390.0 68797.7 73489.6 7867.8 7973.4 7987.9 8213.3 8219.9 35775.3 49636.8 50313.0 50650.0 50882.2 52645.7 65509.0 68181.7 69379.0 70144.0 11006.4 11256.0 11271.5 11369.6 11586.5 9673.8 11650.2 11880.3 12028.3 12576.8 11364.4 11518.1 11776.2 11782.0 12021.6 11629.4 11650.5 11716.6 12151.5 12164.6 11798.6 11895.5 11922.1 11933.8 11936.7 8468.7 9834.0 9918.4 10133.3 10152.0 9319.6 9578.7 9823.7 9832.5 9844.9 13:10:07 INFO - PROCESS | 1662 | -------- Summary: end -------- 13:10:07 INFO - PROCESS | 1662 | 13:10:08 INFO - TEST-INFO | 1662: exit 0 13:10:08 INFO - TEST-OK | dromaeo_css | took 1114183ms 13:10:08 INFO - TEST-START | kraken 13:10:08 INFO - operating with platform_type : mac_ 13:10:08 INFO - Initialising browser for kraken test... 13:10:08 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/tmpV0_vds/profile http://localhost:49264/getInfo.html) 13:10:10 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 13:10:10 INFO - PROCESS | 1670 | colorDepth:24 13:10:10 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 13:10:10 INFO - PROCESS | 1670 | __metrics 13:10:10 INFO - PROCESS | 1670 | 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" 13:10:10 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:10:11 INFO - TEST-INFO | 1670: exit 0 13:10:11 INFO - Browser initialized. 13:10:11 INFO - Running cycle 1/1 for kraken test... 13:10:11 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/tmpV0_vds/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:22 INFO - PROCESS | 1673 | RSS: Main: 160731136 13:10:22 INFO - PROCESS | 1673 | 13:10:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 13:10:26 INFO - PROCESS | 1673 | RSS: Main: 223805440 13:10:26 INFO - PROCESS | 1673 | 13:10:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 13:10:29 INFO - PROCESS | 1673 | RSS: Main: 239636480 13:10:29 INFO - PROCESS | 1673 | 13:10:32 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 13:10:33 INFO - PROCESS | 1673 | RSS: Main: 324714496 13:10:33 INFO - PROCESS | 1673 | 13:10:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 13:10:35 INFO - PROCESS | 1673 | RSS: Main: 230326272 13:10:35 INFO - PROCESS | 1673 | 13:10:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:10:38 INFO - PROCESS | 1673 | RSS: Main: 232562688 13:10:38 INFO - PROCESS | 1673 | 13:10:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 13:10:41 INFO - PROCESS | 1673 | RSS: Main: 269688832 13:10:41 INFO - PROCESS | 1673 | 13:10:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 13:10:45 INFO - PROCESS | 1673 | RSS: Main: 270016512 13:10:45 INFO - PROCESS | 1673 | 13:10:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 13:10:48 INFO - PROCESS | 1673 | RSS: Main: 269471744 13:10:48 INFO - PROCESS | 1673 | 13:10:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:10:50 INFO - PROCESS | 1673 | RSS: Main: 260546560 13:10:50 INFO - PROCESS | 1673 | 13:10:52 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:10:53 INFO - PROCESS | 1673 | RSS: Main: 268025856 13:10:53 INFO - PROCESS | 1673 | 13:10:55 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:10:56 INFO - PROCESS | 1673 | RSS: Main: 270823424 13:10:56 INFO - PROCESS | 1673 | 13:10:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:10:59 INFO - PROCESS | 1673 | RSS: Main: 277966848 13:10:59 INFO - PROCESS | 1673 | 13:11:02 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:11:02 INFO - PROCESS | 1673 | RSS: Main: 275079168 13:11:02 INFO - PROCESS | 1673 | 13:11:04 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 13:11:05 INFO - PROCESS | 1673 | RSS: Main: 336048128 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | __start_tp_report 13:11:05 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 13:11:05 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 13:11:05 INFO - PROCESS | 1673 | |i|pagename|runs| 13:11:05 INFO - PROCESS | 1673 | |0;ai-astar;113;114;121;113;111;109;113;113;113;135 13:11:05 INFO - PROCESS | 1673 | |1;audio-beat-detection;157;117;138;164;121;140;120;151;150;116 13:11:05 INFO - PROCESS | 1673 | |2;audio-dft;184;186;186;184;185;183;185;184;183;177 13:11:05 INFO - PROCESS | 1673 | |3;audio-fft;69;78;72;150;56;54;58;67;127;55 13:11:05 INFO - PROCESS | 1673 | |4;audio-oscillator;90;93;142;79;77;102;122;80;77;124 13:11:05 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;88;86;87;85;87;83;88;85;87;83 13:11:05 INFO - PROCESS | 1673 | |6;imaging-darkroom;92;92;93;92;93;92;106;128;94;94 13:11:05 INFO - PROCESS | 1673 | |7;imaging-desaturate;129;141;87;86;84;85;85;84;83;85 13:11:05 INFO - PROCESS | 1673 | |8;json-parse-financial;58;62;63;63;63;62;65;79;59;57 13:11:05 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;62;63;65;78;74;70;66;66;67;66 13:11:05 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;79;79;79;79;77;80;79;78;79;83 13:11:05 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;128;130;147;142;133;143;125;125;145;136 13:11:05 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;166;153;164;165;195;148;177;200;200;168 13:11:05 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;57;88;93;92;66;66;67;66;69;69 13:11:05 INFO - PROCESS | 1673 | __end_tp_report 13:11:05 INFO - PROCESS | 1673 | __start_cc_report 13:11:05 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1858 13:11:05 INFO - PROCESS | 1673 | __end_cc_report 13:11:05 INFO - PROCESS | 1673 | __startTimestamp1469563865005__endTimestamp 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | ------- Summary: start ------- 13:11:05 INFO - PROCESS | 1673 | Number of tests: 14 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:115.50 Median:113.00 stddev:7.50 (6.6%) stddev-sans-first:7.90 13:11:05 INFO - PROCESS | 1673 | Values: 113.0 114.0 121.0 113.0 111.0 109.0 113.0 113.0 113.0 135.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:145.00 stddev:17.91 (12.4%) stddev-sans-first:17.54 13:11:05 INFO - PROCESS | 1673 | Values: 157.0 117.0 138.0 164.0 121.0 140.0 120.0 151.0 150.0 116.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:2.58 (1.4%) stddev-sans-first:2.74 13:11:05 INFO - PROCESS | 1673 | Values: 184.0 186.0 186.0 184.0 185.0 183.0 185.0 184.0 183.0 177.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:78.60 Median:62.50 stddev:33.01 (52.8%) stddev-sans-first:34.83 13:11:05 INFO - PROCESS | 1673 | Values: 69.0 78.0 72.0 150.0 56.0 54.0 58.0 67.0 127.0 55.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:78.00 stddev:23.23 (29.8%) stddev-sans-first:24.43 13:11:05 INFO - PROCESS | 1673 | Values: 90.0 93.0 142.0 79.0 77.0 102.0 122.0 80.0 77.0 124.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.85 (2.1%) stddev-sans-first:1.80 13:11:05 INFO - PROCESS | 1673 | Values: 88.0 86.0 87.0 85.0 87.0 83.0 88.0 85.0 87.0 83.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:92.50 stddev:11.49 (12.4%) stddev-sans-first:12.01 13:11:05 INFO - PROCESS | 1673 | Values: 92.0 92.0 93.0 92.0 93.0 92.0 106.0 128.0 94.0 94.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:85.00 stddev:21.35 (25.1%) stddev-sans-first:18.74 13:11:05 INFO - PROCESS | 1673 | Values: 129.0 141.0 87.0 86.0 84.0 85.0 85.0 84.0 83.0 85.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:6.14 (9.7%) stddev-sans-first:6.22 13:11:05 INFO - PROCESS | 1673 | Values: 58.0 62.0 63.0 63.0 63.0 62.0 65.0 79.0 59.0 57.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:66.50 stddev:4.97 (7.5%) stddev-sans-first:4.82 13:11:05 INFO - PROCESS | 1673 | Values: 62.0 63.0 65.0 78.0 74.0 70.0 66.0 66.0 67.0 66.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:1.55 (2.0%) stddev-sans-first:1.64 13:11:05 INFO - PROCESS | 1673 | Values: 79.0 79.0 79.0 79.0 77.0 80.0 79.0 78.0 79.0 83.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:139.00 stddev:8.40 (6.0%) stddev-sans-first:8.47 13:11:05 INFO - PROCESS | 1673 | Values: 128.0 130.0 147.0 142.0 133.0 143.0 125.0 125.0 145.0 136.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:172.50 stddev:18.85 (10.9%) stddev-sans-first:19.79 13:11:05 INFO - PROCESS | 1673 | Values: 166.0 153.0 164.0 165.0 195.0 148.0 177.0 200.0 200.0 168.0 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:69.00 stddev:12.72 (18.4%) stddev-sans-first:12.05 13:11:05 INFO - PROCESS | 1673 | Values: 57.0 88.0 93.0 92.0 66.0 66.0 67.0 66.0 69.0 69.0 13:11:05 INFO - PROCESS | 1673 | -------- Summary: end -------- 13:11:05 INFO - PROCESS | 1673 | 13:11:05 INFO - TEST-INFO | 1673: exit 0 13:11:05 INFO - TEST-OK | kraken | took 57548ms 13:11:05 INFO - SUITE-END | took 1171s 13:11:06 INFO - Completed test suite (00:19:32) 13:11:06 INFO - javascript benchmark 13:11:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3503.246801937583, 3511.9122021949465, 3530.752847300689, 3577.2308953574975, 3579.2304654499294, 5847.4152584741505, 5901.439363260489, 5921.85195370116, 5926.881462370756, 5957.791477298296, 5893.204417403649, 5962.672053037081, 5965.761369545213, 5971.880562388749, 5980.282366116061, 5266.394364648077, 5357.062514060033, 5420.268263784398, 5436.293281873351, 5498.972505137469, 5424.5117939385445, 5473.370562385317, 5473.781048758045, 5477.260569823063, 5483.067878460652, 5404.83785486434, 5438.401775804678, 5439.265699130626, 5469.206964990074, 5470.316210473691, 5459.617826752109, 5498.257735205736, 5500.4224556421395, 5513.228148059275, 5521.668699878021, 5275.235090911835, 5288.497592728723, 5351.812686555952, 5360.624756267063, 5397.649152805055, 5739.110437882135, 5778.104393818965, 5788.942110578882, 5795.478406943354, 5806.361300256968, 6265.906011409833, 6285.528585356116, 6300.810975670737, 6313.684315784239, 6320.336364681734, 6186.0, 6240.687965601747, 6328.335524769925, 6334.5249106317215, 6339.904901426482, 5367.06076436626, 5770.307563092414, 5990.191324171268, 5998.190244317048, 6088.512918966472, 6488.902666460007, 6520.315366886503, 6522.0, 6522.249941256721, 6532.869342613121, 6153.29237137726, 6168.814935551941, 6184.783532576338, 6250.437460628475, 6388.5528013039575, 6293.2762732285455, 6298.7480500780375, 6299.118123462719, 6319.083732858801, 6320.336364681734, 5386.703731294817, 6200.821843849654, 6311.96844015777, 6317.526185536103, 6332.968335158294, 6252.468540174045, 6278.560500764903, 6340.746370145235, 6347.1114044033875, 6349.07938348946, 4996.7001979881325, 5069.543741063322, 5098.439171691111, 5108.3103780989095, 5133.178691409431, 4559.179347717376, 4568.291914753218, 4580.427446569179, 4590.40324757786, 4612.95387046132, 5870.232244867397, 5900.970495147497, 5957.940420595825, 6096.8780624388155, 6104.938950610437, 6195.845103872349, 6259.029850373199, 6337.7781777637565, 6340.651264180422, 6347.650879201596, 6013.188219590387, 6067.150598916155, 6102.359252278536, 6124.479419249325, 6139.386061393825, 5579.358373787067, 5589.189567512688, 5608.46719561641, 5615.466530679579, 5626.578006649518, 6416.903746443807, 6456.677166141768, 6470.255920569007, 6500.284968653539, 6595.175603049619, 6282.780102696383, 6292.182016337847, 6336.20797400325, 6344.270408903035, 6361.395667411589, 6566.573172743756, 6587.242467116343, 6620.205575330799, 6637.2699003108655, 6654.13496245485, 6274.6548939808745, 6293.307736149111, 6312.779052733133, 6330.968345158429, 6370.362963703593, 6218.5647004711045, 6240.438360547572, 6290.9056364155485, 6295.433410993032, 6307.936920630918, 5243.790248390174, 6043.425874541911, 6270.404311590391, 6310.716017779119, 6328.0824280478155, 6306.369363063657, 6309.810705678837, 6313.2424109107205, 6331.96834015827, 6361.650109244036, 6074.453299203093, 6140.074827791203, 6211.81364559064, 6213.96893015532, 6219.440250377488, 6288.339724328879, 6311.936880631135, 6334.6832658365975, 6337.968310158604, 6353.5870168438905, 6052.636841789331, 6137.931034482759, 6145.231846019247, 6209.192804935329, 6232.345603711727], "value": 5867.849499201238, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.3797775591435, 554.836323284631, 586.6157666728294, 598.5421152818092, 628.6039794929194, 26650.0, 32501.51247731283, 39281.60718392819, 39540.406893896616, 40077.398839017435, 42841.78579107108, 43166.0, 43350.56649433505, 43360.0, 43479.78260108703, 9628.951855240713, 9810.70567882961, 9811.067948544913, 9821.2634052446, 9824.803503929917, 9190.816183676323, 11986.400679966011, 12280.324582147978, 12291.262524248528, 12292.877071229263, 11974.0, 12068.336241506713, 12071.758564828699, 12072.094592905567, 12082.51669933206, 11897.583584574542, 11988.700282492964, 11989.820152697717, 11995.340256285901, 12000.69998250042, 11670.941645291805, 11762.941185294105, 11766.58816941403, 11806.291622502677, 11824.645260642195, 39642.61250856235, 39908.20183596312, 40000.999975000566, 40015.59984400177, 40084.0, 3274.7707660463775, 3288.2765791525826, 3294.1929227339215, 3383.1203886989315, 3400.0819778659625, 27430.314242144104, 27441.31396715078, 27606.0, 27731.722682773318, 28439.431211375657, 2742.3966727319957, 2762.047093752652, 2783.7912156588336, 2784.610154578361, 2842.9431411371866, 322970.0, 325608.7439125602, 327265.0, 327935.0, 328250.0, 37799.05502362408, 38468.42297365542, 38496.230075398336, 38543.145685431795, 59744.40255597388, 37436.25127497489, 37546.81226593904, 37560.0, 37638.24723505515, 37706.81146594304, 15672.216389180496, 15811.762823557656, 15822.60443488899, 15884.76172857408, 15920.363185472452, 12492.25046497213, 12549.058820588492, 12583.245005299712, 13194.142380745412, 13239.867601323864, 7972.880406793903, 8615.0, 8637.69768058115, 8699.652013919498, 8730.17063378978, 3495.598006229265, 3588.4617307404096, 3599.208174201724, 3612.8735494257576, 3625.9456108158397, 1005.3063386263455, 1039.5114296280735, 1046.549983507084, 1074.3768614203743, 1122.3669560789033, 30761.538576921364, 30955.226119346746, 31018.0, 31481.527777083364, 31714.524282135786, 973.1873885305707, 1124.960626378073, 1144.2676686920377, 1255.7300180461061, 1261.148724610884, 15758.369665213493, 15855.762163567555, 15928.964617299838, 16067.839321606869, 16191.757123643154, 588608.0, 595958.0202098961, 596786.0, 597365.0, 598762.0, 63393.0, 64100.0, 64145.67927160428, 64224.0, 64275.678621606596, 1439.330711219288, 1451.985480145206, 1484.3691431141722, 1561.4534912780437, 1566.2560283865073, 28288.00991965271, 28640.283992900346, 29839.403211935205, 29958.850205748833, 30538.389232215675, 45149.54850451453, 49347.50652493429, 49379.0, 49429.25856112233, 49486.75256623694, 391035.044824774, 402751.0, 403055.0, 404435.0, 578410.0, 27683.72316276892, 28338.858305708338, 28672.856635717522, 43423.13153736971, 44682.0, 46563.76718116388, 46938.530614693416, 47439.52560474351, 47601.76199118982, 48323.275150873465, 37807.43288850615, 37843.432348514245, 38798.0, 38839.6116038836, 39438.0, 37805.8886370672, 38349.0, 38636.0, 39140.2171956565, 39185.608143918194, 38990.0, 39217.0, 39469.0, 40834.97912552091, 40909.590904090575, 33040.83479582587, 33563.0, 34417.65582344145, 34511.13722156966, 34532.0, 25845.0, 25893.352666183495, 25935.740642594086, 26101.0, 26275.21174364772], "value": 18992.74572170854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.95890410958907, 411.84349947020127, 419.84255904035984, 422.3938648040062, 427.211794239628, 20543.486412839688, 21245.468863278427, 21259.04334304958, 21561.46096347592, 22608.0, 12225.755484890318, 12552.497900083985, 17098.401555945544, 22028.229011984582, 22099.889500552516, 5044.268581055745, 5232.189010703328, 5305.779670675727, 6289.119523266723, 6313.337099604544, 6234.314225435199, 6245.812625621216, 6288.371162883721, 6288.496920246369, 6292.0, 6071.757129714828, 6211.534134939875, 6240.719167637467, 6244.0, 6270.122182894398, 6186.628802271855, 6226.0349645804745, 6230.470410015154, 6233.937660623381, 6251.406116418956, 5554.72226388679, 5757.510611598019, 6066.029435290377, 6066.454019138255, 6077.4226448487325, 14134.293285335794, 14153.150810951272, 14177.929110354486, 22212.778297193647, 26274.73725262742, 2347.906083756665, 2500.1624455807328, 2544.440223150904, 2741.7121202273674, 2882.538793792983, 9915.80168396628, 10144.644937427229, 10512.948705129502, 10859.40273284969, 14940.95413321068, 1747.615524584602, 1824.917878695462, 1841.4107485604611, 1923.3268356075403, 1958.1677786940636, 69082.3091769081, 87984.0, 114363.0, 120969.99999999913, 125772.0, 11920.403979800974, 11990.460429280703, 11992.820107698391, 12009.399530023464, 12018.33899135556, 14112.364943577564, 14567.198804065667, 15074.246287685572, 15625.0, 15878.364865405254, 8082.2725954664365, 8332.33341332692, 8905.599248033854, 8981.595828187747, 9099.226565741987, 8966.551672416354, 8994.730158095268, 9002.279817614575, 9041.638334466548, 9130.406523575946, 4816.253480710496, 4826.155422800995, 4827.806887724522, 4854.514548545118, 4861.270809378621, 1668.5828542864283, 2012.788657190974, 2029.5433527456205, 2036.0, 2039.4697378681353, 920.2408013388981, 978.3738407419257, 990.6829814459448, 1021.9693409197736, 1075.8224892892742, 20232.096350918542, 20733.27433539819, 20888.686669699968, 20894.47763805917, 20896.47758806042, 981.5239608789731, 1055.7096798380353, 1067.3435836960214, 1093.4314156638504, 1104.4643347976225, 10618.681439556825, 10984.505697243643, 11019.283746556608, 11072.723181920517, 11084.334939903632, 576305.2369476336, 646178.0, 660004.0, 667051.0, 670032.0, 129530.0, 133313.3334333322, 133582.99999999805, 135319.0, 137061.3146934259, 954.9665761698308, 978.8678528398717, 983.8081574092984, 984.0405604535521, 987.8518222266574, 18283.54291142732, 18460.0, 18514.814851851308, 18543.443696689123, 18640.440786776417, 37172.62827371692, 52250.21624675709, 52926.41220763229, 53581.66045848885, 55228.0, 71402.64298678473, 71617.0, 71803.64098179476, 72996.0, 77846.22153778616, 8140.226678465537, 8384.748457546284, 8396.580170991549, 8580.013298470756, 8607.268382187583, 11868.643940681794, 12940.805887911878, 13084.28036458004, 13088.0, 13354.599362019155, 9578.329516933747, 11280.2667826591, 11299.548018079186, 11552.537898483966, 11595.594154204562, 10969.945150274198, 11000.724981875197, 11182.496787644413, 11418.31490110596, 11624.953754161828, 11297.0, 11565.768684626428, 11861.76276474483, 11884.881151188723, 11921.761564768829, 8279.751607451786, 8333.166683331861, 8491.74524764258, 8545.273651739422, 8742.650293988168, 10988.945055274673, 11188.272762270426, 11231.101511879193, 11410.885891141314, 11519.19365644397], "value": 9717.820302396545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.7412065828146, 1631.7307644238701, 1654.3961454069265, 1930.4787707319024, 2032.126185740132, 8195.467294625845, 8792.98880628728, 8906.732798016053, 8911.0, 8919.509426981513, 8596.097409771977, 8864.069272726367, 8871.55642217888, 8873.68942087027, 8877.201051905327, 2516.7860731837814, 2542.148380292604, 2547.5541780188487, 2547.923562293134, 2550.1966880432697, 2485.8384205026705, 2562.782163516094, 2565.884535195911, 2565.9230223093246, 2570.408805974627, 2526.633638122471, 2553.834000789952, 2570.884310206045, 2574.4207553300544, 2574.588065909455, 2045.7647370552354, 2518.320053585531, 2551.795856331489, 2562.1416825363526, 2571.8199726018997, 2509.5859183234743, 2534.809889258295, 2541.0852093246417, 2543.0, 2553.259554729126, 8787.64849406023, 8895.976962649249, 8924.152205540464, 8948.507832069234, 8990.41562298455, 5585.385607583204, 5684.289463817023, 5685.516731077863, 5725.627834190765, 5733.283339582552, 3384.8984530464127, 3558.768680035789, 3628.8911332660064, 3709.8516059357594, 3761.4733937248807, 1069.8716154061485, 1072.3030030480172, 1087.494315143462, 1103.5254840418618, 1104.7072525780675, 12085.697857553543, 12169.634910952685, 12171.93914030433, 12207.084468664885, 12216.328101954388, 4666.533346665306, 4737.857864264078, 4745.383100197021, 4797.7601119943865, 4808.206645903457, 9498.430094194371, 9499.192568631745, 9501.857472137923, 9511.191548718298, 9521.143097121292, 5425.6202065855805, 5425.810096646598, 5434.266374039533, 5437.102878025082, 5441.537469315073, 3786.7159963002887, 4688.179568575554, 4939.90120197594, 5089.872753181126, 5100.0819852426175, 3958.0, 3982.38273067675, 4031.5162180537936, 4071.063655359225, 4071.714979951434, 1269.8920591749804, 1273.7134144817342, 1274.216356940475, 1283.9871601284055, 1289.6775806048488, 951.5432592355708, 966.9419834809934, 971.8736564246602, 981.5582987655583, 1011.6459239266198, 6085.908711369245, 6087.3303936566945, 6092.8781424372155, 6224.782132625427, 6249.937500625027, 475.32029198246147, 489.3589397888777, 495.20766773162654, 498.8029728257318, 499.7501249375312, 3743.8689645862264, 3784.6215378461934, 3854.1713531590844, 3859.9614003860165, 3872.0513474199, 10631.46842657864, 11096.722581935515, 11112.611058612909, 11114.388708620942, 11124.443777811239, 10839.187060970458, 10970.067544258667, 10974.0, 10975.792662807085, 11011.779764404668, 8400.781886626404, 8604.225619694258, 8607.311415086779, 8614.569271536398, 8642.827143457096, 5297.682139071668, 5603.10350343943, 5667.489925906523, 6013.188219590299, 6059.6364218147055, 9638.614455421985, 9809.41143531362, 9981.0, 10005.849912251468, 10032.749181270234, 8043.798905027421, 9962.501874906371, 9995.250356223167, 10175.338602990782, 10211.489425528842, 5706.629069110494, 6746.460283177236, 6969.919662452328, 7171.605561693948, 7178.60517671533, 8474.237318641352, 8491.830163396575, 8555.743327700178, 8555.743327700178, 8570.828583428422, 7431.331180193809, 7573.886391704239, 7657.510193149023, 7659.693612255447, 7695.192004839635, 7471.6637751302405, 7484.251574842472, 7506.136794268729, 7611.923880761122, 7638.885416718865, 7195.604241766753, 7251.41988640918, 7255.600941948243, 7271.272872712686, 7272.127344718456, 4782.641301902441, 4828.179209534317, 4965.255211718127, 5003.149464590955, 5033.5721463676, 4960.900781984412, 5004.84985450437, 5026.421961474477, 5050.9747451263975, 5088.338515993045], "value": 4605.962112319556, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.2844256406163, 337.16887871397, 340.9846556904939, 344.57617130928975, 346.0017848507058, 6547.901781473276, 6550.279469258384, 6590.275069742324, 6591.110200122982, 6592.340765923417, 6537.313582073885, 6547.544670748469, 6559.048937904001, 6588.967055164718, 6590.934090659092, 4672.813087476506, 4781.832635857746, 4790.5448982346625, 4900.387451568554, 4918.975405122969, 4885.340479035321, 4971.651984361096, 4977.527134922195, 4988.251762235657, 5021.372328458942, 4896.338994235768, 4905.068037072945, 4909.582685471739, 4925.26121081837, 4931.580815630676, 4658.161530924433, 4719.43366795985, 4861.076395484882, 4862.124817532843, 4877.439094504142, 4170.249355116078, 4212.073343864376, 4225.598568136053, 4228.112096459748, 4247.851325203603, 6254.655993920333, 6290.276618188921, 6300.401461861115, 6301.369863013708, 6326.145970293997, 5736.684482353469, 5737.2254745609225, 5748.655080695172, 5753.741081651336, 5760.279965004374, 6773.4242589379965, 6971.407430368425, 7020.29797020299, 7020.5787652741, 7035.33164349386, 4689.671722979393, 4704.223803072489, 4707.857924644313, 4740.217864052427, 4743.596794272491, 5619.269494965628, 6277.937220627781, 7090.822729431754, 7327.377172940306, 7432.628368581603, 4766.713997160112, 4776.8566942991765, 4796.496367881392, 4798.160321943646, 4804.015176888729, 4836.661433699607, 4860.9513904861205, 4872.829450969199, 4873.049755297683, 4885.2427873679635, 4625.629949604024, 5707.885842283131, 5726.255586773693, 5763.0, 5769.249997500298, 6737.59574425536, 6984.2317345092, 7021.438284937193, 7029.789106326818, 7087.220405755363, 1673.564873132994, 1683.6380178261732, 1697.6944150052861, 1698.8471037606428, 1707.1976171199517, 1023.7389465686202, 1038.4496217004998, 1082.7293176705823, 1083.7778255457613, 1103.9834402483968, 6579.868402631921, 6827.52207345481, 6832.248452670202, 6841.965790171117, 6868.141482314711, 6742.089817874622, 7348.522346047596, 7372.668229929666, 7403.5928023959195, 7415.925840741524, 5511.503964643121, 6072.72472780721, 6746.460283177334, 6749.797506074826, 6810.353016463428, 3479.112826229346, 3743.6256374362347, 3847.1728578355787, 3867.5358956925347, 3867.7292589518465, 6771.492138089565, 6973.81445154325, 7719.228077192236, 7734.342580880576, 7769.79568166935, 6325.8929687304535, 7476.327130558276, 7523.28528789775, 7624.046994125734, 7630.236976302436, 7726.304632583095, 7750.0, 7750.883736743841, 7793.7272195474025, 7793.766187014398, 6997.230304666381, 7035.8039133348475, 7040.753573625104, 7364.815879603053, 7369.410447164321, 7175.497715159889, 7208.098987626547, 7223.494355395282, 7224.458165637703, 7235.493515453868, 7709.691612335444, 7722.38220942312, 7730.0, 7734.845303093794, 7740.225977402215, 4641.953580464287, 4707.105649926503, 4710.128626204163, 4715.363425937455, 4716.0, 6998.725414240291, 7354.896765485006, 7370.115586129485, 7372.004779354718, 7379.8155046124275, 7074.858502830018, 7124.715011399693, 7130.928690713026, 7139.82150446243, 7147.85704285901, 7114.6442677866935, 7120.821979450555, 7136.324792731851, 7139.428845692229, 7143.071400718081, 6966.233714291525, 6968.616726080114, 6982.68577913985, 6984.615846128511, 6992.0910281663055, 5711.914321285101, 6870.175578930561, 7102.928970710227, 7115.395191408788, 7117.43060555144, 6596.505262105457, 6765.627890466071, 6773.390394864486, 6803.353681400259, 6959.478039147186], "value": 5175.127357069753, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.1240873725321, 763.2672634271099, 765.7281665008921, 780.0717146595551, 824.5877061469264, 15328.770068448983, 15478.226088695563, 15517.224138793043, 15532.223388830556, 17695.380661676845, 16194.514164575052, 16264.83735162648, 16265.91867040663, 16281.674366512692, 16353.591160221, 774.5623722596742, 964.161179773598, 977.3891317926297, 985.4579981010452, 985.6402413119196, 794.5749024272016, 952.4666186935339, 987.6641941739807, 988.2785566536432, 989.3074847606669, 1034.7930413917209, 1037.6783197208852, 1038.3717850700332, 1039.2361614213546, 1041.7031146123356, 756.587659725451, 769.1385648074137, 1026.194437366671, 1027.2552399510332, 1027.881793593735, 736.7237286017744, 762.1121393576477, 763.1300317637897, 763.3511515212081, 764.1785081037907, 12673.0, 15371.538853834403, 15551.844481555152, 15570.766438503319, 15610.375584976588, 12958.0, 13084.0, 13238.86761132386, 13262.8222110036, 13457.192568445924, 9978.501074946296, 10092.293539452241, 10094.848577271347, 10127.746806329827, 10165.542550585242, 3560.2345495718287, 3582.3551760683067, 3589.335972845006, 3590.1922067534856, 3640.1263696712863, 81690.59154704248, 82899.5855020727, 83126.58436707838, 83781.16218837794, 83910.58044709798, 9836.803263934824, 9849.45827979468, 9864.0, 10290.485475726184, 11038.061764749926, 22933.853307334568, 23143.421414464436, 23150.42123946881, 23204.419889502897, 23208.071677132724, 7563.092428908456, 7753.147153813076, 7932.762017139495, 7977.401694872908, 8055.234752698484, 3502.8073455960166, 4168.499780026355, 4221.155768846182, 4224.598663126998, 4388.758618276025, 3602.7117830574016, 3748.5126933498473, 3817.3128836809087, 3837.57786643469, 3840.6543411093135, 692.4979389942251, 697.9581225126509, 706.1067749297143, 710.6304721544872, 712.8431745016192, 566.7336351914594, 571.223136534313, 571.6541492397123, 592.3987153039668, 602.4788557897388, 7788.415868809862, 7872.094709108412, 8813.294936405073, 8918.286537077149, 9179.403338782959, 582.3710392775791, 586.8444862111544, 615.53527087049, 639.4979940746491, 647.3364801078837, 3813.790241536742, 4004.8798536043964, 4058.4723985882238, 4062.7968601569805, 4187.895302617398, 98380.52429213567, 99421.0, 99934.00065999392, 100380.99238015345, 101037.49481252547, 76322.0, 78853.60573197211, 79140.41719165584, 82075.0, 83678.58160709158, 49128.0, 67089.6582068356, 68389.97415038779, 68797.65601171962, 73489.63255183797, 7867.763967080997, 7973.441859070042, 7987.880181797162, 8213.301869341172, 8219.876701849358, 35775.284494309446, 49636.751816240685, 50313.0, 50650.0, 50882.23676644779, 52645.68385790386, 65509.0, 68181.65909170422, 69379.0, 70144.0, 11006.449677516252, 11256.043236324676, 11271.549138034386, 11369.602063927723, 11586.536538538365, 9673.806523869624, 11650.186641251701, 11880.346580937785, 12028.27830330183, 12576.811347829973, 11364.374959377314, 11518.078553715515, 11776.234544754563, 11782.0, 12021.639350819489, 11629.434300213807, 11650.475728592402, 11716.589919352782, 12151.513939442324, 12164.635060948185, 11798.646040618794, 11895.464704088165, 11922.105842062054, 11933.761324773282, 11936.701582460508, 8468.66125354979, 9834.0, 9918.37979137624, 10133.290669653348, 10151.98480151979, 9319.6272149116, 9578.66474673411, 9823.705288841345, 9832.508374581099, 9844.852327215242], "value": 7122.825613884786, "unit": "score"}], "name": "dromaeo_css", "value": 7540.973516305529, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 121.0, 113.0, 111.0, 109.0, 113.0, 113.0, 113.0, 135.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 117.0, 138.0, 164.0, 121.0, 140.0, 120.0, 151.0, 150.0, 116.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 186.0, 184.0, 185.0, 183.0, 185.0, 184.0, 183.0, 177.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 72.0, 150.0, 56.0, 54.0, 58.0, 67.0, 127.0, 55.0], "value": 78.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 142.0, 79.0, 77.0, 102.0, 122.0, 80.0, 77.0, 124.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 85.0, 87.0, 83.0, 88.0, 85.0, 87.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 92.0, 93.0, 92.0, 106.0, 128.0, 94.0, 94.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 141.0, 87.0, 86.0, 84.0, 85.0, 85.0, 84.0, 83.0, 85.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 63.0, 63.0, 63.0, 62.0, 65.0, 79.0, 59.0, 57.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 78.0, 74.0, 70.0, 66.0, 66.0, 67.0, 66.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 77.0, 80.0, 79.0, 78.0, 79.0, 83.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 147.0, 142.0, 133.0, 143.0, 125.0, 125.0, 145.0, 136.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 153.0, 164.0, 165.0, 195.0, 148.0, 177.0, 200.0, 200.0, 168.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 88.0, 93.0, 92.0, 66.0, 66.0, 67.0, 66.0, 69.0, 69.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1484.5, "alertThreshold": 2.0}]} 13:11:06 INFO - Return code: 0 13:11:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:11:06 ERROR - # TBPL SUCCESS # 13:11:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:11:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:11:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:11:06 INFO - 2016-07-26 13:11:06.322 screenresolution[1677:9965] starting screenresolution argv=screenresolution get 13:11:06 INFO - 2016-07-26 13:11:06.325 screenresolution[1677:9965] Display 0: 1600x1200x32@60 13:11:06 INFO - 2016-07-26 13:11:06.331 screenresolution[1678:9968] starting screenresolution argv=screenresolution list 13:11:06 INFO - Available Modes on Display 0 13:11:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:11:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:11:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:11:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:11:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:11:06 INFO - Intel Iris: 13:11:06 INFO - Chipset Model: Intel Iris 13:11:06 INFO - Type: GPU 13:11:06 INFO - Bus: Built-In 13:11:06 INFO - VRAM (Dynamic, Max): 1536 MB 13:11:06 INFO - Vendor: Intel (0x8086) 13:11:06 INFO - Device ID: 0x0a2e 13:11:06 INFO - Revision ID: 0x0009 13:11:06 INFO - Displays: 13:11:06 INFO - Display: 13:11:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:11:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:11:06 INFO - Display Serial Number: 1600x1200 60 13:11:06 INFO - Main Display: Yes 13:11:06 INFO - Mirror: Off 13:11:06 INFO - Online: Yes 13:11:06 INFO - Rotation: Supported 13:11:06 INFO - Return code: 0 13:11:06 INFO - Running post-action listener: _resource_record_post_action 13:11:06 INFO - Running post-run listener: _resource_record_post_run 13:11:07 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 37234176; Write bytes: 496835584; Read time: 251; Write time: 1504 13:11:07 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194836992; Write bytes: 196801536; Read time: 17744; Write time: 436 13:11:07 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 35415552; Write bytes: 296702976; Read time: 234; Write time: 1061 13:11:07 INFO - Running post-run listener: _upload_blobber_files 13:11:07 INFO - Blob upload gear active. 13:11:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:11:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:11:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:11:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:11:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:11:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:09 INFO - (blobuploader) - INFO - Done attempting. 13:11:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:11:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:11:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:10 INFO - (blobuploader) - INFO - Done attempting. 13:11:10 INFO - (blobuploader) - INFO - Iteration through files over. 13:11:10 INFO - Return code: 0 13:11:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:11:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:11:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4db40ec51e96d1dcf976cfeb7b20afe18a3fcad76db50c3b0a56b9ded10b9205762078e838fb3b4b6e222dfb4b612cade7fe674a18c6c112041b4052a029588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ebf0442a3464b59a7ee2e426391b804a4682ccb0e19907017d0d55c850907bba1c21f47ee35bd9bc3ad678eb87754da1f111043cba76ce3669de7a4fff18eca"} 13:11:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:11:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:11:10 INFO - Contents: 13:11:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4db40ec51e96d1dcf976cfeb7b20afe18a3fcad76db50c3b0a56b9ded10b9205762078e838fb3b4b6e222dfb4b612cade7fe674a18c6c112041b4052a029588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ebf0442a3464b59a7ee2e426391b804a4682ccb0e19907017d0d55c850907bba1c21f47ee35bd9bc3ad678eb87754da1f111043cba76ce3669de7a4fff18eca"} 13:11:10 INFO - Running post-run listener: copy_logs_to_upload_dir 13:11:10 INFO - Copying logs to upload dir... 13:11:10 INFO - mkdir: /builds/slave/test/build/upload/logs 13:11:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.486258 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-26 13:11:10.269267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 13:11:10.272716) ========= 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.6R9WdPCTRF/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.0s8nemmtfa/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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/b4db40ec51e96d1dcf976cfeb7b20afe18a3fcad76db50c3b0a56b9ded10b9205762078e838fb3b4b6e222dfb4b612cade7fe674a18c6c112041b4052a029588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ebf0442a3464b59a7ee2e426391b804a4682ccb0e19907017d0d55c850907bba1c21f47ee35bd9bc3ad678eb87754da1f111043cba76ce3669de7a4fff18eca"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010992 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469543878/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4db40ec51e96d1dcf976cfeb7b20afe18a3fcad76db50c3b0a56b9ded10b9205762078e838fb3b4b6e222dfb4b612cade7fe674a18c6c112041b4052a029588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ebf0442a3464b59a7ee2e426391b804a4682ccb0e19907017d0d55c850907bba1c21f47ee35bd9bc3ad678eb87754da1f111043cba76ce3669de7a4fff18eca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 13:11:10.307450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:11:10.307763) ========= 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.6R9WdPCTRF/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.0s8nemmtfa/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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.005313 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:11:10.356926) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 13:11:10.357249) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 13:11:10.357662) ========= ========= Total master_lag: 0.18 =========