builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0066 starttime: 1469265433.97 results: success (0) buildid: 20160722223058 builduid: d1d5169c325b43d2bb38c51b324b3a4a revision: c928b117ae5a0948253484872e4d98f99a4b5eff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:13.968412) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:13.968907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:13.969204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:14.287084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:14.287410) ========= 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.aLDTUijPNh/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.xhKJbPnCSW/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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-23 02:17:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-07-23 02:17:14 (37.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.519021 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:14.842106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:14.842440) ========= 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.aLDTUijPNh/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.xhKJbPnCSW/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020454 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:14.971283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-23 02:17:14.971655) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c928b117ae5a0948253484872e4d98f99a4b5eff --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 c928b117ae5a0948253484872e4d98f99a4b5eff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aLDTUijPNh/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.xhKJbPnCSW/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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-23 02:17:15,055 truncating revision to first 12 chars 2016-07-23 02:17:15,056 Setting DEBUG logging. 2016-07-23 02:17:15,056 attempt 1/10 2016-07-23 02:17:15,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c928b117ae5a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-23 02:17:16,416 unpacking tar archive at: mozilla-beta-c928b117ae5a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.617686 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-23 02:17:16.628103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:16.628443) ========= script_repo_revision: c928b117ae5a0948253484872e4d98f99a4b5eff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:16.628877) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:16.629157) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-23 02:17:16.658446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-23 02:17:16.658743) ========= /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.aLDTUijPNh/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.xhKJbPnCSW/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 02:17:16 INFO - MultiFileLogger online at 20160723 02:17:16 in /builds/slave/test 02:17:16 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 02:17:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:17:16 INFO - {'append_to_log': False, 02:17:16 INFO - 'base_work_dir': '/builds/slave/test', 02:17:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:17:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:17:16 INFO - 'branch': 'Mozilla-Beta', 02:17:16 INFO - 'buildbot_json_path': 'buildprops.json', 02:17:16 INFO - 'config_files': ('talos/mac_config.py',), 02:17:16 INFO - 'default_actions': ('clobber', 02:17:16 INFO - 'read-buildbot-config', 02:17:16 INFO - 'download-and-extract', 02:17:16 INFO - 'populate-webroot', 02:17:16 INFO - 'create-virtualenv', 02:17:16 INFO - 'install', 02:17:16 INFO - 'run-tests'), 02:17:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:17:16 INFO - 'download_minidump_stackwalk': True, 02:17:16 INFO - 'download_symbols': 'ondemand', 02:17:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:17:16 INFO - 'tooltool.py': '/tools/tooltool.py', 02:17:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:17:16 INFO - '/tools/misc-python/virtualenv.py')}, 02:17:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:17:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:17:16 INFO - 'installer_path': 'installer.exe', 02:17:16 INFO - 'log_level': 'info', 02:17:16 INFO - 'log_name': 'talos', 02:17:16 INFO - 'log_to_console': True, 02:17:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:17:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:17:16 INFO - 'opt_config_files': (), 02:17:16 INFO - 'pip_index': False, 02:17:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:17:16 INFO - 'cmd': ('bash', 02:17:16 INFO - '-c', 02:17:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:17:16 INFO - 'enabled': True, 02:17:16 INFO - 'halt_on_failure': False, 02:17:16 INFO - 'name': 'check_screen_resolution'},), 02:17:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:17:16 INFO - 'cmd': ('bash', 02:17:16 INFO - '-c', 02:17:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:17:16 INFO - 'enabled': True, 02:17:16 INFO - 'halt_on_failure': False, 02:17:16 INFO - 'name': 'check_screen_resolution'},), 02:17:16 INFO - 'run_cmd_checks_enabled': True, 02:17:16 INFO - 'sps_profile': False, 02:17:16 INFO - 'sps_profile_interval': 0, 02:17:16 INFO - 'suite': 'dromaeojs', 02:17:16 INFO - 'system_bits': '32', 02:17:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:17:16 INFO - 'title': 't-yosemite-r7-0066', 02:17:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:17:16 INFO - 'use_talos_json': True, 02:17:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:17:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:17:16 INFO - 'work_dir': 'build'} 02:17:16 INFO - ##### 02:17:16 INFO - ##### Running clobber step. 02:17:16 INFO - ##### 02:17:16 INFO - Running pre-action listener: _resource_record_pre_action 02:17:16 INFO - Running main action method: clobber 02:17:16 INFO - rmtree: /builds/slave/test/build 02:17:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:17:18 INFO - Running post-action listener: _resource_record_post_action 02:17:18 INFO - ##### 02:17:18 INFO - ##### Running read-buildbot-config step. 02:17:18 INFO - ##### 02:17:18 INFO - Running pre-action listener: _resource_record_pre_action 02:17:18 INFO - Running main action method: read_buildbot_config 02:17:18 INFO - Using buildbot properties: 02:17:18 INFO - { 02:17:18 INFO - "project": "", 02:17:18 INFO - "product": "firefox", 02:17:18 INFO - "script_repo_revision": "production", 02:17:18 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 02:17:18 INFO - "repository": "", 02:17:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 02:17:18 INFO - "buildid": "20160722223058", 02:17:18 INFO - "pgo_build": "False", 02:17:18 INFO - "basedir": "/builds/slave/test", 02:17:18 INFO - "buildnumber": 52, 02:17:18 INFO - "slavename": "t-yosemite-r7-0066", 02:17:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:17:18 INFO - "platform": "yosemite_r7", 02:17:18 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:17:18 INFO - "branch": "mozilla-beta", 02:17:18 INFO - "repo_path": "releases/mozilla-beta", 02:17:18 INFO - "revision": "c928b117ae5a0948253484872e4d98f99a4b5eff", 02:17:18 INFO - "stage_platform": "macosx64", 02:17:18 INFO - "builduid": "d1d5169c325b43d2bb38c51b324b3a4a", 02:17:18 INFO - "slavebuilddir": "test" 02:17:18 INFO - } 02:17:18 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.dmg. 02:17:18 INFO - Running post-action listener: _resource_record_post_action 02:17:18 INFO - ##### 02:17:18 INFO - ##### Running download-and-extract step. 02:17:18 INFO - ##### 02:17:18 INFO - Running pre-action listener: _resource_record_pre_action 02:17:18 INFO - Running main action method: download_and_extract 02:17:18 INFO - mkdir: /builds/slave/test/build/tests 02:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.test_packages.json 02:17:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 02:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/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 02:17:18 INFO - Downloaded 1165 bytes. 02:17:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 02:17:18 INFO - Using the following test package requirements: 02:17:18 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:17:18 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:17:18 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 02:17:18 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:17:18 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 02:17:18 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:17:18 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:17:18 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 02:17:18 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:17:18 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:17:18 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 02:17:18 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:17:18 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 02:17:18 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:17:18 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 02:17:18 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:17:18 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 02:17:18 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 02:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.common.tests.zip 02:17:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 02:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/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 02:17:21 INFO - Downloaded 18314897 bytes. 02:17:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:17:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:17:24 INFO - Return code: 0 02:17:24 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 02:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:24 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.common.tests.zip 02:17:24 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 02:17:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/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 02:17:27 INFO - Downloaded 18314897 bytes. 02:17: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'] 02:17: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 02:17:30 INFO - Return code: 0 02:17: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')]} 02:17:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.talos.tests.zip 02:17:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 02:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/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 02:17:31 INFO - Downloaded 10840145 bytes. 02:17:31 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'] 02:17:31 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 02:17:31 INFO - Return code: 0 02:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.dmg 02:17:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 02:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 02:17:38 INFO - Downloaded 86190371 bytes. 02:17:38 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.dmg 02:17:38 INFO - mkdir: /builds/slave/test/properties 02:17:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:17:38 INFO - Writing to file /builds/slave/test/properties/build_url 02:17:38 INFO - Contents: 02:17:38 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.dmg 02:17:38 INFO - Running post-action listener: _resource_record_post_action 02:17:38 INFO - Running post-action listener: set_extra_try_arguments 02:17:38 INFO - ##### 02:17:38 INFO - ##### Running populate-webroot step. 02:17:38 INFO - ##### 02:17:38 INFO - Running pre-action listener: _resource_record_pre_action 02:17:38 INFO - Running main action method: populate_webroot 02:17:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:17:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:17:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:17:38 INFO - '--tppagecycles', 02:17:38 INFO - '7'], 02:17:38 INFO - 'tests': ['tsvgm']}}, 02:17:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:17:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:17:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:17:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:17:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:17:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:17:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:38 INFO - 'talos_options': ['--disable-e10s'], 02:17:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:38 INFO - 'talos_options': ['--disable-e10s'], 02:17:38 INFO - 'tests': ['damp', 'tps']}, 02:17:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:38 INFO - 'tests': ['damp', 'tps']}, 02:17:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:17:38 INFO - 'tests': ['dromaeo_dom']}, 02:17:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:17:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:17:38 INFO - 'tests': ['a11yr', 02:17:38 INFO - 'ts_paint', 02:17:38 INFO - 'tpaint', 02:17:38 INFO - 'sessionrestore', 02:17:38 INFO - 'sessionrestore_no_auto_restore', 02:17:38 INFO - 'tabpaint']}, 02:17:38 INFO - 'other-e10s': {'tests': ['a11yr', 02:17:38 INFO - 'ts_paint', 02:17:38 INFO - 'tpaint', 02:17:38 INFO - 'sessionrestore', 02:17:38 INFO - 'sessionrestore_no_auto_restore', 02:17:38 INFO - 'tabpaint']}, 02:17:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:17:38 INFO - 'ts_paint', 02:17:38 INFO - 'tpaint', 02:17:38 INFO - 'sessionrestore', 02:17:38 INFO - 'sessionrestore_no_auto_restore', 02:17:38 INFO - 'tabpaint']}, 02:17:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:17:38 INFO - 'ts_paint', 02:17:38 INFO - 'tpaint', 02:17:38 INFO - 'sessionrestore', 02:17:38 INFO - 'sessionrestore_no_auto_restore', 02:17:38 INFO - 'tabpaint']}, 02:17:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:17:38 INFO - 'tests': ['a11yr', 02:17:38 INFO - 'ts_paint', 02:17:38 INFO - 'tpaint', 02:17:38 INFO - 'sessionrestore', 02:17:38 INFO - 'sessionrestore_no_auto_restore', 02:17:38 INFO - 'tabpaint']}, 02:17:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:17:38 INFO - 'tests': ['a11yr', 02:17:38 INFO - 'ts_paint', 02:17:38 INFO - 'tpaint', 02:17:38 INFO - 'sessionrestore', 02:17:38 INFO - 'sessionrestore_no_auto_restore', 02:17:38 INFO - 'tabpaint']}, 02:17:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:17:38 INFO - 'tests': ['tsvgx', 02:17:38 INFO - 'tsvgr_opacity', 02:17:38 INFO - 'tart', 02:17:38 INFO - 'tscrollx', 02:17:38 INFO - 'cart']}, 02:17:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:17:38 INFO - 'tsvgr_opacity', 02:17:38 INFO - 'tart', 02:17:38 INFO - 'tscrollx', 02:17:38 INFO - 'cart']}, 02:17:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:38 INFO - 'talos_options': ['--disable-e10s'], 02:17:38 INFO - 'tests': ['tp5o']}, 02:17:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:38 INFO - 'tests': ['tp5o']}, 02:17:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:38 INFO - 'talos_options': ['--disable-e10s', 02:17:38 INFO - '--xperf_path', 02:17:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:38 INFO - 'tests': ['tp5n']}, 02:17:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:38 INFO - 'talos_options': ['--xperf_path', 02:17:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:38 INFO - 'tests': ['tp5n']}}, 02:17:38 INFO - 'talos.zip': {'path': '', 02:17:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:17:38 INFO - Running post-action listener: _resource_record_post_action 02:17:38 INFO - ##### 02:17:38 INFO - ##### Running create-virtualenv step. 02:17:38 INFO - ##### 02:17:38 INFO - Running pre-action listener: _resource_record_pre_action 02:17:38 INFO - Running main action method: create_virtualenv 02:17:38 INFO - Creating virtualenv /builds/slave/test/build/venv 02:17:38 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 02:17:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:17:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:17:38 INFO - Using real prefix '/tools/python27' 02:17:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:17:39 INFO - Installing distribute.............................................................................................................................................................................................done. 02:17:42 INFO - Installing pip.................done. 02:17:42 INFO - Return code: 0 02:17:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a1c8dfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786ee00>, '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 0x1076d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107869b20>, '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.aLDTUijPNh/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.xhKJbPnCSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 02:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:17:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aLDTUijPNh/Render', 02:17:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:17:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:17:42 INFO - 'HOME': '/Users/cltbld', 02:17:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:17:42 INFO - 'LOGNAME': 'cltbld', 02:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:42 INFO - 'MOZ_NO_REMOTE': '1', 02:17:42 INFO - 'NO_EM_RESTART': '1', 02:17:42 INFO - 'PAGER': '/bin/cat', 02:17:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:42 INFO - 'PWD': '/builds/slave/test', 02:17:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:17:42 INFO - 'SHELL': '/bin/bash', 02:17:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xhKJbPnCSW/Listeners', 02:17:42 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 02:17:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:17:42 INFO - 'USER': 'cltbld', 02:17:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:17:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:42 INFO - 'XPC_FLAGS': '0x0', 02:17:42 INFO - 'XPC_SERVICE_NAME': '0', 02:17:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:42 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 02:17:42 INFO - Cleaning up... 02:17:42 INFO - Return code: 0 02:17:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1079cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a1c8dfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786ee00>, '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 0x1076d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107869b20>, '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.aLDTUijPNh/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.xhKJbPnCSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 02:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:17:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aLDTUijPNh/Render', 02:17:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:17:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:17:42 INFO - 'HOME': '/Users/cltbld', 02:17:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:17:42 INFO - 'LOGNAME': 'cltbld', 02:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:42 INFO - 'MOZ_NO_REMOTE': '1', 02:17:42 INFO - 'NO_EM_RESTART': '1', 02:17:42 INFO - 'PAGER': '/bin/cat', 02:17:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:42 INFO - 'PWD': '/builds/slave/test', 02:17:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:17:42 INFO - 'SHELL': '/bin/bash', 02:17:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xhKJbPnCSW/Listeners', 02:17:42 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 02:17:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:17:42 INFO - 'USER': 'cltbld', 02:17:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:17:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:42 INFO - 'XPC_FLAGS': '0x0', 02:17:42 INFO - 'XPC_SERVICE_NAME': '0', 02:17:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:43 INFO - Downloading/unpacking psutil>=0.7.1 02:17:43 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 02:17:43 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 02:17:43 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 02:17:43 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 02:17:43 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 02:17:43 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 02:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:17:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:17:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:17:46 INFO - Installing collected packages: psutil 02:17:46 INFO - Running setup.py install for psutil 02:17:47 INFO - building 'psutil._psutil_osx' extension 02:17:47 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 02:17:47 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 02:17:47 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 02:17:47 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 02:17:47 INFO - building 'psutil._psutil_posix' extension 02:17:47 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 02:17:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:17:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:17:47 INFO - ^ 02:17:47 INFO - 1 warning generated. 02:17:47 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 02:17:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:17:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:17:47 INFO - Successfully installed psutil 02:17:47 INFO - Cleaning up... 02:17:47 INFO - Return code: 0 02:17:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:17: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')]} 02:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17: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')]} 02:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17: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', '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 0x1079cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a1c8dfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786ee00>, '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 0x1076d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107869b20>, '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.aLDTUijPNh/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.xhKJbPnCSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 02:17: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:17: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 mozsystemmonitor==0.0.0 02:17:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aLDTUijPNh/Render', 02:17:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:17:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:17:47 INFO - 'HOME': '/Users/cltbld', 02:17:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:17:47 INFO - 'LOGNAME': 'cltbld', 02:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:47 INFO - 'MOZ_NO_REMOTE': '1', 02:17:47 INFO - 'NO_EM_RESTART': '1', 02:17:47 INFO - 'PAGER': '/bin/cat', 02:17:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:47 INFO - 'PWD': '/builds/slave/test', 02:17:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:17:47 INFO - 'SHELL': '/bin/bash', 02:17:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xhKJbPnCSW/Listeners', 02:17:47 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 02:17:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:17:47 INFO - 'USER': 'cltbld', 02:17:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:17:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:47 INFO - 'XPC_FLAGS': '0x0', 02:17:47 INFO - 'XPC_SERVICE_NAME': '0', 02:17:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:17:50 INFO - Installing collected packages: mozsystemmonitor 02:17:50 INFO - Running setup.py install for mozsystemmonitor 02:17:50 INFO - Successfully installed mozsystemmonitor 02:17:50 INFO - Cleaning up... 02:17:50 INFO - Return code: 0 02:17:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:50 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 0x1079cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a1c8dfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786ee00>, '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 0x1076d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107869b20>, '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.aLDTUijPNh/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.xhKJbPnCSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 02:17:50 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 02:17:50 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 02:17:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aLDTUijPNh/Render', 02:17:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:17:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:17:50 INFO - 'HOME': '/Users/cltbld', 02:17:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:17:50 INFO - 'LOGNAME': 'cltbld', 02:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:50 INFO - 'MOZ_NO_REMOTE': '1', 02:17:50 INFO - 'NO_EM_RESTART': '1', 02:17:50 INFO - 'PAGER': '/bin/cat', 02:17:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:50 INFO - 'PWD': '/builds/slave/test', 02:17:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:17:50 INFO - 'SHELL': '/bin/bash', 02:17:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xhKJbPnCSW/Listeners', 02:17:50 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 02:17:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:17:50 INFO - 'USER': 'cltbld', 02:17:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:17:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:50 INFO - 'XPC_FLAGS': '0x0', 02:17:50 INFO - 'XPC_SERVICE_NAME': '0', 02:17:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:51 INFO - Downloading/unpacking blobuploader==1.2.4 02:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:53 INFO - Downloading blobuploader-1.2.4.tar.gz 02:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:17:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:17:53 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 02:17:53 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 02:17:53 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 02:17:53 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 02:17:53 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 02:17:53 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 02:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:17:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:54 INFO - Downloading docopt-0.6.1.tar.gz 02:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:17:54 INFO - Installing collected packages: blobuploader, requests, docopt 02:17:54 INFO - Running setup.py install for blobuploader 02:17:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:17:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:17:54 INFO - Running setup.py install for requests 02:17:55 INFO - Running setup.py install for docopt 02:17:55 INFO - Successfully installed blobuploader requests docopt 02:17:55 INFO - Cleaning up... 02:17:55 INFO - Return code: 0 02:17:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:55 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 0x1079cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a1c8dfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786ee00>, '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 0x1076d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107869b20>, '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.aLDTUijPNh/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.xhKJbPnCSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 02:17:55 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 02:17:55 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 02:17:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aLDTUijPNh/Render', 02:17:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:17:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:17:55 INFO - 'HOME': '/Users/cltbld', 02:17:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:17:55 INFO - 'LOGNAME': 'cltbld', 02:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:55 INFO - 'MOZ_NO_REMOTE': '1', 02:17:55 INFO - 'NO_EM_RESTART': '1', 02:17:55 INFO - 'PAGER': '/bin/cat', 02:17:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:55 INFO - 'PWD': '/builds/slave/test', 02:17:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:17:55 INFO - 'SHELL': '/bin/bash', 02:17:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xhKJbPnCSW/Listeners', 02:17:55 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 02:17:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:17:55 INFO - 'USER': 'cltbld', 02:17:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:17:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:55 INFO - 'XPC_FLAGS': '0x0', 02:17:55 INFO - 'XPC_SERVICE_NAME': '0', 02:17:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:17:55 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-tlHVp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:17:56 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-hYaUOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:17:56 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-8FnJWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:17:56 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-tSoEZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:17:56 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Ma_yMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:17:56 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-sLFmI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:17:56 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-8ZbR2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:17:56 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-xGaaZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:17:56 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-MfgGtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:17:56 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-4ItI9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:17:56 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-FgSYWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:17:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-W4cQOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:17:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ADwSZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:17:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-4zqfH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:17:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-9Q_o1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:17:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-QI78wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:17:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-c6yTlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:17:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:17:57 INFO - Running setup.py install for manifestparser 02:17:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:17:57 INFO - Running setup.py install for mozcrash 02:17:57 INFO - Running setup.py install for mozdebug 02:17:58 INFO - Running setup.py install for mozdevice 02:17:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:17:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:17:58 INFO - Running setup.py install for mozfile 02:17:58 INFO - Running setup.py install for mozhttpd 02:17:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:17:58 INFO - Running setup.py install for mozinfo 02:17:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:17:58 INFO - Running setup.py install for mozInstall 02:17:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:17:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:17:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:17:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:17:58 INFO - Running setup.py install for mozleak 02:17:59 INFO - Running setup.py install for mozlog 02:17:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:17:59 INFO - Running setup.py install for moznetwork 02:17:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:17:59 INFO - Running setup.py install for mozprocess 02:17:59 INFO - Running setup.py install for mozprofile 02:17:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:17:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:17:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:17:59 INFO - Running setup.py install for mozrunner 02:17:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:17:59 INFO - Running setup.py install for mozscreenshot 02:17:59 INFO - Running setup.py install for moztest 02:18:00 INFO - Running setup.py install for mozversion 02:18:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:18:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:18:00 INFO - Cleaning up... 02:18:00 INFO - Return code: 0 02:18:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:00 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 0x1079cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a1c8dfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786ee00>, '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 0x1076d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107869b20>, '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.aLDTUijPNh/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.xhKJbPnCSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 02:18:00 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 02:18:00 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 02:18:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aLDTUijPNh/Render', 02:18:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:00 INFO - 'HOME': '/Users/cltbld', 02:18:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:00 INFO - 'LOGNAME': 'cltbld', 02:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:00 INFO - 'MOZ_NO_REMOTE': '1', 02:18:00 INFO - 'NO_EM_RESTART': '1', 02:18:00 INFO - 'PAGER': '/bin/cat', 02:18:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:00 INFO - 'PWD': '/builds/slave/test', 02:18:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:00 INFO - 'SHELL': '/bin/bash', 02:18:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xhKJbPnCSW/Listeners', 02:18:00 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 02:18:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:00 INFO - 'USER': 'cltbld', 02:18:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:00 INFO - 'XPC_FLAGS': '0x0', 02:18:00 INFO - 'XPC_SERVICE_NAME': '0', 02:18:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-PkB1SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:00 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)) 02:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-6eLGRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:00 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)) 02:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-UzT7Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:00 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)) 02:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Sv79Ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:00 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)) 02:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-BjULXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:01 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)) 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:01 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-PSROcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:01 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)) 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:01 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-jtuEwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:01 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)) 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:01 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-XxOdaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:01 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)) 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:01 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Z2nWkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:01 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)) 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:01 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-voj0XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:01 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)) 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:01 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-gcpvKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:01 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)) 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:01 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-_OaVKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:01 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)) 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:01 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-T9T4nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:01 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)) 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:01 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-2iSAKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:02 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)) 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-iIcJTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:02 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)) 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-BerWxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:02 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)) 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-BpATyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:02 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)) 02:18:02 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)) 02:18:02 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)) 02:18:02 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)) 02:18:02 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)) 02:18:02 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)) 02:18:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18:04 INFO - Downloading blessings-1.6.tar.gz 02:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:18:04 INFO - Installing collected packages: blessings 02:18:04 INFO - Running setup.py install for blessings 02:18:05 INFO - Successfully installed blessings 02:18:05 INFO - Cleaning up... 02:18:05 INFO - Return code: 0 02:18:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:05 INFO - Reading from file tmpfile_stdout 02:18:05 INFO - Current package versions: 02:18:05 INFO - blessings == 1.6 02:18:05 INFO - blobuploader == 1.2.4 02:18:05 INFO - docopt == 0.6.1 02:18:05 INFO - manifestparser == 1.1 02:18:05 INFO - mozInstall == 1.12 02:18:05 INFO - mozcrash == 0.17 02:18:05 INFO - mozdebug == 0.1 02:18:05 INFO - mozdevice == 0.48 02:18:05 INFO - mozfile == 1.2 02:18:05 INFO - mozhttpd == 0.7 02:18:05 INFO - mozinfo == 0.9 02:18:05 INFO - mozleak == 0.1 02:18:05 INFO - mozlog == 3.1 02:18:05 INFO - moznetwork == 0.27 02:18:05 INFO - mozprocess == 0.22 02:18:05 INFO - mozprofile == 0.28 02:18:05 INFO - mozrunner == 6.11 02:18:05 INFO - mozscreenshot == 0.1 02:18:05 INFO - mozsystemmonitor == 0.0 02:18:05 INFO - moztest == 0.7 02:18:05 INFO - mozversion == 1.4 02:18:05 INFO - psutil == 3.1.1 02:18:05 INFO - requests == 1.2.3 02:18:05 INFO - wsgiref == 0.1.2 02:18:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:05 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 0x1079cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a1c8dfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786ee00>, '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 0x1076d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107869b20>, '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.aLDTUijPNh/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.xhKJbPnCSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 02:18:05 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 02:18:05 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 02:18:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aLDTUijPNh/Render', 02:18:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:05 INFO - 'HOME': '/Users/cltbld', 02:18:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:05 INFO - 'LOGNAME': 'cltbld', 02:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:05 INFO - 'MOZ_NO_REMOTE': '1', 02:18:05 INFO - 'NO_EM_RESTART': '1', 02:18:05 INFO - 'PAGER': '/bin/cat', 02:18:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:05 INFO - 'PWD': '/builds/slave/test', 02:18:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:05 INFO - 'SHELL': '/bin/bash', 02:18:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xhKJbPnCSW/Listeners', 02:18:05 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 02:18:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:05 INFO - 'USER': 'cltbld', 02:18:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:05 INFO - 'XPC_FLAGS': '0x0', 02:18:05 INFO - 'XPC_SERVICE_NAME': '0', 02:18:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:05 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)) 02:18:05 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)) 02:18:05 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)) 02:18:05 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)) 02:18:05 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)) 02:18:05 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)) 02:18:05 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)) 02:18:05 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)) 02:18:05 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)) 02:18:05 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)) 02:18:05 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)) 02:18:05 INFO - Cleaning up... 02:18:05 INFO - Return code: 0 02:18:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a1c8dfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786ee00>, '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 0x1076d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107869b20>, '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.aLDTUijPNh/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.xhKJbPnCSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 02:18: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', 'jsonschema'] in /builds/slave/test/build 02:18: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 jsonschema 02:18:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aLDTUijPNh/Render', 02:18:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:05 INFO - 'HOME': '/Users/cltbld', 02:18:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:05 INFO - 'LOGNAME': 'cltbld', 02:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:05 INFO - 'MOZ_NO_REMOTE': '1', 02:18:05 INFO - 'NO_EM_RESTART': '1', 02:18:05 INFO - 'PAGER': '/bin/cat', 02:18:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:05 INFO - 'PWD': '/builds/slave/test', 02:18:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:05 INFO - 'SHELL': '/bin/bash', 02:18:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xhKJbPnCSW/Listeners', 02:18:05 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 02:18:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:05 INFO - 'USER': 'cltbld', 02:18:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:05 INFO - 'XPC_FLAGS': '0x0', 02:18:05 INFO - 'XPC_SERVICE_NAME': '0', 02:18:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:05 INFO - Downloading/unpacking jsonschema 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:18:08 INFO - Downloading/unpacking functools32 (from jsonschema) 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:18:08 INFO - warning: no files found matching '*.txt' 02:18:08 INFO - no previously-included directories found matching 'build' 02:18:08 INFO - no previously-included directories found matching 'dist' 02:18:08 INFO - no previously-included directories found matching '.git*' 02:18:08 INFO - Installing collected packages: jsonschema, functools32 02:18:08 INFO - Running setup.py install for functools32 02:18:09 INFO - warning: no files found matching '*.txt' 02:18:09 INFO - no previously-included directories found matching 'build' 02:18:09 INFO - no previously-included directories found matching 'dist' 02:18:09 INFO - no previously-included directories found matching '.git*' 02:18:09 INFO - Successfully installed jsonschema functools32 02:18:09 INFO - Cleaning up... 02:18:09 INFO - Return code: 0 02:18:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:09 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 0x1079cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079df420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a1c8dfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10786ee00>, '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 0x1076d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107869b20>, '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.aLDTUijPNh/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.xhKJbPnCSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 02:18:09 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 02:18:09 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 02:18:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aLDTUijPNh/Render', 02:18:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:09 INFO - 'HOME': '/Users/cltbld', 02:18:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:09 INFO - 'LOGNAME': 'cltbld', 02:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:09 INFO - 'MOZ_NO_REMOTE': '1', 02:18:09 INFO - 'NO_EM_RESTART': '1', 02:18:09 INFO - 'PAGER': '/bin/cat', 02:18:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:09 INFO - 'PWD': '/builds/slave/test', 02:18:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:09 INFO - 'SHELL': '/bin/bash', 02:18:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xhKJbPnCSW/Listeners', 02:18:09 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 02:18:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:09 INFO - 'USER': 'cltbld', 02:18:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:09 INFO - 'XPC_FLAGS': '0x0', 02:18:09 INFO - 'XPC_SERVICE_NAME': '0', 02:18:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:09 INFO - Downloading/unpacking flake8 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:18:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:18:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:18:13 INFO - no previously-included directories found matching 'docs/_build' 02:18:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:18:13 INFO - Running setup.py install for pep8 02:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:18:13 INFO - no previously-included directories found matching 'docs/_build' 02:18:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:18:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:18:13 INFO - Cleaning up... 02:18:13 INFO - Return code: 0 02:18:13 INFO - Running post-action listener: _resource_record_post_action 02:18:13 INFO - Running post-action listener: _start_resource_monitoring 02:18:13 INFO - Starting resource monitoring. 02:18:13 INFO - ##### 02:18:13 INFO - ##### Running install step. 02:18:13 INFO - ##### 02:18:13 INFO - Running pre-action listener: _resource_record_pre_action 02:18:13 INFO - Running main action method: install 02:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:13 INFO - Reading from file tmpfile_stdout 02:18:13 INFO - Detecting whether we're running mozinstall >=1.0... 02:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:18:14 INFO - Reading from file tmpfile_stdout 02:18:14 INFO - Output received: 02:18:14 INFO - Usage: mozinstall [options] installer 02:18:14 INFO - Options: 02:18:14 INFO - -h, --help show this help message and exit 02:18:14 INFO - -d DEST, --destination=DEST 02:18:14 INFO - Directory to install application into. [default: 02:18:14 INFO - "/builds/slave/test"] 02:18:14 INFO - --app=APP Application being installed. [default: firefox] 02:18:14 INFO - mkdir: /builds/slave/test/build/application 02:18:14 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'] 02:18:14 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 02:18:35 INFO - Reading from file tmpfile_stdout 02:18:35 INFO - Output received: 02:18:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:18:35 INFO - Running post-action listener: _resource_record_post_action 02:18:35 INFO - ##### 02:18:35 INFO - ##### Running run-tests step. 02:18:35 INFO - ##### 02:18:35 INFO - Running pre-action listener: _resource_record_pre_action 02:18:35 INFO - Running main action method: run_tests 02:18:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:18:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:18:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:18:35 INFO - 2016-07-23 02:18:35.938 screenresolution[1923:17021] starting screenresolution argv=screenresolution get 02:18:35 INFO - 2016-07-23 02:18:35.940 screenresolution[1923:17021] Display 0: 1600x1200x32@60 02:18:35 INFO - 2016-07-23 02:18:35.946 screenresolution[1924:17023] starting screenresolution argv=screenresolution list 02:18:35 INFO - Available Modes on Display 0 02:18:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:18:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:18:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:18:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:18:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:18:36 INFO - Intel Iris: 02:18:36 INFO - Chipset Model: Intel Iris 02:18:36 INFO - Type: GPU 02:18:36 INFO - Bus: Built-In 02:18:36 INFO - VRAM (Dynamic, Max): 1536 MB 02:18:36 INFO - Vendor: Intel (0x8086) 02:18:36 INFO - Device ID: 0x0a2e 02:18:36 INFO - Revision ID: 0x0009 02:18:36 INFO - Displays: 02:18:36 INFO - Display: 02:18:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:18:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:18:36 INFO - Display Serial Number: 1600x1200 60 02:18:36 INFO - Main Display: Yes 02:18:36 INFO - Mirror: Off 02:18:36 INFO - Online: Yes 02:18:36 INFO - Rotation: Supported 02:18:36 INFO - Return code: 0 02:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:18:36 INFO - Python 2.7.3 02:18:36 INFO - Return code: 0 02:18:36 INFO - grabbing minidump binary from tooltool 02:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:36 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 0x10786ee00>, '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 0x1076d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107869b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:18:36 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 02:18:36 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 02:18:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:18:36 INFO - Return code: 0 02:18:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:18:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:18:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:18:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:18:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:18:37 INFO - Return code: 0 02:18:37 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/1469251858/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 02:18:37 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/1469251858/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --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 02:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aLDTUijPNh/Render', 02:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:37 INFO - 'HOME': '/Users/cltbld', 02:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:37 INFO - 'LOGNAME': 'cltbld', 02:18:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:18:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:37 INFO - 'MOZ_NO_REMOTE': '1', 02:18:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:18:37 INFO - 'NO_EM_RESTART': '1', 02:18:37 INFO - 'PAGER': '/bin/cat', 02:18:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:37 INFO - 'PWD': '/builds/slave/test', 02:18:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:37 INFO - 'SHELL': '/bin/bash', 02:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xhKJbPnCSW/Listeners', 02:18:37 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 02:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:37 INFO - 'USER': 'cltbld', 02:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:37 INFO - 'XPC_FLAGS': '0x0', 02:18:37 INFO - 'XPC_SERVICE_NAME': '0', 02:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:37 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/1469251858/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 02:18:37 INFO - mozversion application_buildid: 20160722223058 02:18:37 INFO - mozversion application_changeset: c928b117ae5a0948253484872e4d98f99a4b5eff 02:18:37 INFO - mozversion application_display_name: Firefox 02:18:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:18:37 INFO - mozversion application_name: Firefox 02:18:37 INFO - mozversion application_remotingname: firefox 02:18:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:18:37 INFO - mozversion application_vendor: Mozilla 02:18:37 INFO - mozversion application_version: 48.0 02:18:37 INFO - mozversion platform_buildid: 20160722223058 02:18:37 INFO - mozversion platform_changeset: c928b117ae5a0948253484872e4d98f99a4b5eff 02:18:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:18:37 INFO - mozversion platform_version: 48.0 02:18:37 INFO - using testdate: 1469265517 02:18:37 INFO - actual date: 1469265517 02:18:37 INFO - starting webserver on 'localhost:52294' 02:18:37 INFO - SUITE-START | Running 2 tests 02:18:37 INFO - TEST-START | dromaeo_css 02:18:37 INFO - operating with platform_type : mac_ 02:18:37 INFO - Initialising browser for dromaeo_css test... 02:18:37 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpFSPxEp/profile http://localhost:52294/getInfo.html) 02:18:39 INFO - PROCESS | 1942 | __metrics Screen width/height:1600/1200 02:18:39 INFO - PROCESS | 1942 | colorDepth:24 02:18:39 INFO - PROCESS | 1942 | Browser inner width/height: 1024/689 02:18:39 INFO - PROCESS | 1942 | __metrics 02:18:39 INFO - PROCESS | 1942 | 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" 02:18:39 ERROR - PROCESS | 1942 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:18:40 INFO - TEST-INFO | 1942: exit 0 02:18:40 INFO - Browser initialized. 02:18:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:18:40 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpFSPxEp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:18:52 INFO - PROCESS | 1945 | RSS: Main: 160645120 02:18:52 INFO - PROCESS | 1945 | 02:19:43 INFO - PROCESS | 1945 | 1469265583913 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] 02:21:53 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:52294/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52294/tests/dromaeo/cssquery-ext.html) 02:21:55 INFO - PROCESS | 1945 | RSS: Main: 256028672 02:21:55 INFO - PROCESS | 1945 | 02:24:57 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:52294/tests/dromaeo/cssquery-ext.html (next: http://localhost:52294/tests/dromaeo/cssquery-jquery.html) 02:24:58 INFO - PROCESS | 1945 | RSS: Main: 303054848 02:24:58 INFO - PROCESS | 1945 | 02:28:00 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:52294/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52294/tests/dromaeo/cssquery-mootools.html) 02:28:00 INFO - PROCESS | 1945 | RSS: Main: 308744192 02:28:00 INFO - PROCESS | 1945 | 02:31:03 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:52294/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52294/tests/dromaeo/cssquery-prototype.html) 02:31:03 INFO - PROCESS | 1945 | RSS: Main: 307044352 02:31:03 INFO - PROCESS | 1945 | 02:34:06 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:52294/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52294/tests/dromaeo/cssquery-yui.html) 02:34:07 INFO - PROCESS | 1945 | RSS: Main: 275152896 02:34:07 INFO - PROCESS | 1945 | 02:37:09 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:52294/tests/dromaeo/cssquery-yui.html (next: http://localhost:52294/tests/dromaeo/cssquery-dojo.html) 02:37:10 INFO - PROCESS | 1945 | RSS: Main: 311291904 02:37:10 INFO - PROCESS | 1945 | 02:37:10 INFO - PROCESS | 1945 | __start_tp_report 02:37:10 INFO - PROCESS | 1945 | _x_x_mozilla_page_load 02:37:10 INFO - PROCESS | 1945 | _x_x_mozilla_page_load_details 02:37:10 INFO - PROCESS | 1945 | |i|pagename|runs| 02:37:10 INFO - PROCESS | 1945 | |0;dojo.html;3557.9288414231714;3604;3632.9273414531704;3650.5984341722424;3706.7775933443995;5992.490638295744;6005.309389420218;6010.8196754097335;6034.332411490649;6062.363451837559;6037.849053773658;6068.6965651717455;6069.4840938520165;6075.149479072933;6081.847953801157;4628.560286772751;5291.126964050927;5381.54256888164;5454.372747134091;5508.228847961269;5281.841544753664;5483.561315094803;5484.369297530795;5489.58828087895;5496.340439147308;4529.614982726473;5404.594655400841;5412.972935135338;5425.945740542603;5449.836504904859;5464.371597266306;5483.369412517532;5485;5511.696856672881;5542.944570554283;5315.495027972375;5321.308229930123;5371.328583927009;5430.619856610039;5445.019896418683;5861.003629382973;5866.325372582165;5869.1196320551835;5875.647461152302;5921.407859214044;6291.937080629226;6295.96852015737;6311.084892690534;6341.270753863272;6354.364563543655;5711.114777209539;6326.304106548322;6421.550491465599;6427.132337134521;6445.484361251136;6144.170536977451;6154.753809847601;6163.876722465526;6182.567220294626;6195.16365290689;6564.376384243489;6582.934170658328;6585.835354116185;6603.042558828943;6610.504212184105;6216.782412615627;6224.844378890564;6297.748090076346;6323.241211054703;6326.114343991845;6432.935670643327;6445.097686323918;6449.064885591657;6449.645269510222;6454.354564543602;6231.158793562901;6274.027525733519;6284.591501552384;6290.119383286344;6296.811095667137;6225.844353891099;6251.062340648939;6292.559520833589;6301.464375528039;6308.495320374359;5099.745012749348;5141.562967147835;5149.150390185652;5157.329547158845;5166.302549155891;4639;4669.579737823544;4673.696209746356;4679.859604211879;4689.906201875943;6015.699215039231;6059.697015149225;6136.140940268366;6147.5553244987395;6149.41580549847;6406.007068904327;6408.935910640834;6418.037294405876;6435;6437.195350581177;6098.847528811726;6144.569880108439;6162.969185154046;6163.476104531075;6167.074938759222;5520.254765606672;5533.6403133796175;5613.831585052455;5620.016497112989;5626.971865140648;6600.174978127734;6628.5691430056895;6642.734290628514;6648.96675516629;6695.598264104169;6247.281562620356;6380.425761681471;6383.234011918599;6392.712327945161;6393.744250229939;6567.9671601641685;6653.401193892573;6679.198496180489;6686.69909854048;6688.966555167193;6299.338569450142;6318.494520438446;6319.494440444845;6320.652364119834;6328.082428047999;6238.438540531374;6295.905561416674;6348.428641422294;6355.237371515448;6460.160179176677;6248.781292654735;6278.874422511615;6285.528585356025;6296.496280297657;6313.210848643919;6278.591891527219;6290.496760259077;6290.528210384331;6294.15028971083;6296.181496405438;6116.235470566179;6116.244470650343;6237.719302631302;6249.218847644044;6282.654454005074;6169.2288463942;6196.1015652731;6228.439440450381;6287.434130928238;6313.589616674902;6257;6266.122742816101;6271.059341098689;6277.12120303167;6278.811635650938 02:37:10 INFO - PROCESS | 1945 | |1;ext.html;517.9689218646881;526.8340472751083;554.3846330573065;590.9438603332685;630.0077378129447;32352.352952940928;32970.34059318812;33024.83487582562;33123.17192070199;40112.39831402531;43452.56547434525;43926.560734392646;44016.3397549037;44035.77982110085;44061.33907991383;9490.620375185;9732.07545283197;9735.318527703064;9757.121859032686;9765;9130.360874738772;9557.56990935406;9686.515674216296;11709.355985420798;11978.221415608;11455.427228638577;11712.590059347924;11820.645380638594;11821.7635647287;11823.113266505003;10067.345622534513;11627.59303424376;11707.180497365187;11804.822927656092;11814.468348924276;11600.825987610193;11699.18105732599;11707.356095414749;11708.238964467282;11709.121815863844;40357.79821100905;40751.7962410189;42683.78658106721;42766.358504622454;42770.78614606907;3255.6581558936446;3311.2549676322874;3315.4529502632035;3435.4846772984;3447.379471695094;27545.898164073413;28362.007329743567;28409.85795071032;28410.857945710344;28723.856380717963;2720.9591856122174;2785.373291009527;2814.4230432761233;2823.5905793659804;2881.236472334833;341320.29339853144;341746.29126854456;342612.2869385662;342616;348721;63271.36728632747;69773;71474;71535.56928861393;71769.2823071773;67870.66064669644;67892.660536697;67944;68125.61560345364;68326.65836670884;18237.635247295246;18430.539236518925;18451.90774046121;18472.261109555468;18490.352837650888;13187.802182967263;13813.171209727248;13876.236806975714;13921.095128816796;14081.2959352032;17953.640927181383;20778.584428311653;21298.893505532684;21351.46621334448;21371.893140534197;7257.745978890714;8012.879806802903;8383.706570270133;8462.746117616482;8675.436096653697;951.7620594851287;989.8663680403198;1025.9692209233735;1104.8287515434959;1129.3280498103616;24181;28769.71230287712;28833.279168020967;29089.854550727112;29498.115056547907;624.5316012990257;1100.6697990602788;1133.3426612564692;1156.5373850459882;1160.3444054109402;13645.727085458235;14837.851621483647;16163.757543636855;16367.91816040912;16540.503784886474;631068;632837;645214;646472;647139;65279;65960.01059984104;65975.37135457499;66116;66300.33699662941;1374.4227424481742;1391.8956078294168;1516.1812621184438;1552.6428921347926;1642.6714657068635;28799.42401152007;30143;30178.547321789752;30323;31055.689443106185;52465;52658.473415265355;53346.73326633497;53378.73310633422;53459;420381;423181;424067.87966059975;425242;427144;24969.75030249674;25435.745642543337;28386.574201386582;28787.28031799222;29124.854375727984;44526.55473445354;47548.28677569908;47874.04251915012;48204.758976204896;49259;37694;38950;39068.804655976535;39222.60777392304;40322.395164071975;38208.235835283696;38443.038924027125;38667.80666096652;39375.80312098421;39451;38691.613083869925;38762.49423914619;39451.80274098611;39536.209275813744;39542;31939.36121277608;33433.49849752207;34154.80458183952;34221.31557368889;34451;22416.43454039036;25523.87238063872;25672.743272567037;25795.871020644776;25922.61116083298 02:37:10 INFO - PROCESS | 1945 | |2;jquery.html;410.46895081346577;412.84931000184935;412.9731567448114;415.60725114766547;421.49631190727075;20166.672499037642;20545.86997715125;21128.788712112873;21289.148434062638;21289.787102128976;18063.36778212763;21055.578888422224;21376.251831185913;22199.22302719405;22208;5971.790987315456;6016.338202797689;6275.811725648238;6277.560570760049;6279.34066922971;6154.384561543855;6216.098665693472;6237.500999920018;6248.31268560458;6248.468880145193;5969.5821292509545;6231.875362492748;6250;6255.59338642989;6260.123582698426;5142.305788718512;6093.786717464912;6119.051547010198;6128.57100003;6224.595401298901;5616.831495055155;5947.524198064145;5949.107633854913;5968.641881487081;5971.581989260753;13462.730745385135;13668.726625467534;14056.226907520082;14068.859311406959;14080.014398992074;2147.1733382647635;2154.9245776397906;2179.8256139508803;2504.8371855829314;2560.7823335016546;10020.34867733595;10131.392116473035;10208.336458130198;10261.640842570474;10517.1060459861;1707.743838424234;1722.2249987505547;1757.850582700472;1770.9026003569797;1780.4569606270084;88305;111847.32229016571;115607;116406;117943.41028294804;11652.650420487398;11893.226940248856;12016;12107.213031152947;12107.273563586214;15439.768403473958;15459.381624734884;15484.845151548565;15490.380384784708;15498.225088745517;9012.188902998761;9094.545272736468;9102.86345704815;9191.586378612978;9230.630774769068;8977.32670049749;8991.640334386682;9015.14356136166;9067.229285510673;9136.406133601295;4185;4659.161350956861;4766.880827979328;4790.760461976887;4805.111054454937;1664.9750253746204;2029.9391018269475;2040.6734922412343;2043.540203454211;2069.9793002070087;909.7862002429424;944.6504793226413;1014.6398028699853;1037.4138611684375;1055.6358056470506;20465.976701164884;20777.688334674993;20978.79021209799;21054.315494788352;21132.577348452945;999.9150072243941;1022.2026819081128;1025.7692019295748;1046.612753281291;1100.9559617615205;11002.834957475645;11408.828867566826;11420.94289528547;11463.45243392148;11474.87714772753;591920;596129;597929;625402.7459725436;643223;116322.67354653029;117530;118203;121611.78388216182;124006;1015.8374660054355;1056.2025670618634;1062.0335494699787;1064.6273804168634;1085.1318944844093;18401.72397414013;18850.3402380916;19108.33120840764;19156.521086972938;19312.8068719311;51448.48551514437;53702.462975369745;56181;57314;57407.13889291747;79117.60441197758;83085.58457207675;83413;83715;85442;8033.517988920684;8059.516429014044;8467.745967620982;8470.237678608955;8497.192766687154;10984.780304394028;11163.44182790841;12553.93723031379;12898.48406063747;13146.802797957847;10771.730706732395;10940.343579385262;11319.886801131883;11364.147688923198;11378.08975281992;9854.802903942025;10309.659744233202;10749;10938.56245750161;11355.148363872908;10923.508442119964;11385.715357116138;11457.026152777107;11458.77082458363;11700.88299116998;8339.874901876598;8430.283425908867;8454.816325714282;8630.82738345242;8838.292936565187;11194.888051119384;11364.829527556927;11555.711107222387;11633.709157271136;11741.236819606698 02:37:10 INFO - PROCESS | 1945 | |3;mootools.html;1410.7672234081376;1496.2967405319496;1642.9753553696694;1886.7924528301894;2065.9276925307618;8234.011918569773;8962.507062111581;9083.091690830914;9135.269178465724;9151;8806.64773409063;9090;9110;9112.635494580209;9116.270698344133;2528.747125287475;2551.081610620175;2551.1963731424635;2555.56555385584;2556.0670355320267;2209.2709405896017;2474.591692370757;2481.5161043596504;2552.0302285131625;2553.872306384683;2525.7979361651023;2536.2771610091127;2560.8591527465983;2561.7310182430856;2570.0362364113457;2508.7240403555684;2537.8096642751775;2546.2997675639162;2557.6419301297647;2567.332493551671;2497.8501289922665;2538.1497198438547;2545.7072436669837;2548.5157820014324;2551.7496426750945;8892.73321800347;9219.35464517484;9275.860862087075;9300.302477314228;9310.208632266265;5559.861003474945;5712.057510510761;5719.942800571983;5766.394528574523;5787.1608616750755;3666.7983260920637;3741.2330472253393;3786.2238241160494;3798.7530810497506;3818.6372294631965;1043.8903915088958;1061.1245722279073;1062.8352605346106;1075.3494136047734;1103.426218366445;11990.580329688506;12118;12388;12396.81404778929;12404.317762523058;4738.976305118521;4781.091592597395;4823.5658790709;4828.082664293773;4915.090708218991;8147.592620368958;8363.874541881876;9675.371100878421;9684.70945871625;9724.95137524308;5605;5610.663360198401;5617.43825617435;5619.241402410704;5629.183768353566;4662.300654901792;4821.951780482221;5070.391553013662;5126.92309615356;5230.738463076831;4011.3180759270995;4071.9389209161886;4137.379393091061;4141.171765646883;4171.83312667496;1283.6598301450124;1286.8455785305823;1287.8776516230944;1296.623979046085;1299.7140629061591;869.8216865542676;914.8216097860986;947.6683160893632;948.4878165790534;958.242988039441;5972.432618901197;6091.8172454825535;6104.847378815565;6144.8771024580155;6196.256449226122;466.7642840365594;468.6953480237873;479.19256053549185;482.4210946863777;485.9198232291703;3966.662833659171;3990.780507072081;4024.879253622396;4091.5499295077516;4124.876253712393;10891.183161262938;11291.983721464943;11390;11458.255213411101;11488.138389620812;10441.738956526147;10778.245522813328;10928.180386471047;11172.832407513893;11175.776484470265;8612.827743445096;8649.394542381973;8676.479411235347;8725.607347669371;8778.736637901002;5769.192313076089;6042.516598672184;6106.755729770759;6177.96911015442;6261.123442718114;9961.50192490387;10170.338927969658;10347.689569312932;10351.016653417913;10355.171586272929;9500.572474238814;9841;9883.357581757164;9915.107640312406;10082.193424525874;7039;7193.4604904631315;7197.820054498679;7758.68965241384;7950.4832185907735;7897.723579674684;8353.164683531599;8561.57192140378;8599.796028555882;8616.396852220285;7521.849563008818;7643.961780191064;7722.343600793995;7736.878152667944;7775.650095745818;6292.716827742671;7559.622018899143;7567.432442566719;7653.923460765321;7678.923210768045;7240.239774823778;7293;7297.927020729937;7298;7310.890336645061;4680.836170734008;4743.193657078236;4910.729909854992;4919.2129259318335;5113.335266415491;5085.847424577269;5098.923516147187;5132.281480592795;5154.484551544965;5197.0905091608065 02:37:10 INFO - PROCESS | 1945 | |4;prototype.html;333.8116305950815;340.63981042654035;344.4626382842765;351.55879371388903;352.8676746220166;5553.722313884305;6593.175853018372;6664.166979127615;6739.955306927422;6834.658267086638;6500.609963402199;6522.445592124664;6669.633170175651;6737.528373013891;6739.561928474645;4959.107360675077;5019.945811379596;5026.045051440233;5048.469910659383;5066.316047333618;5053.64624476285;5076.492350764913;5095.980803839228;5105.591552675795;5112.41207261166;4759.90480190396;4856.935802284032;5018.573421259179;5024.371953505812;5039.974800126012;4999.400071991385;5009.599232061426;5026.924596131061;5037.4458809530925;5046.293518907356;3649.7810131391934;4209.621134097915;4340.262155433584;4343.717658352197;4350.216960947028;5208.687478751249;6528.608283502957;6529.5429319947625;6546.639934803584;6566.376194261537;5982.461578457916;5994.400559944014;5998.340182579913;6023.698815059273;6031.487323577501;6106.48094911933;6959.6868140933775;7182.533135346186;7231.602261875595;7239.20368759436;4855.368802055746;4884.267359896008;4898.2162853943555;4900.191468407708;4910.116179087763;7543.547387156788;7649.617519124022;7652.426068044919;7655.885161722578;7660.195679453688;4943.1596628573225;4950.009998000414;4957.925631115536;4968.975155124202;4977.402711674622;5040.899182016339;5042.596592272609;5045.949540504622;5057.064443078042;5060.114479965991;5782.710864456761;6000;6002.459778619857;6011.218541589653;6024.3975602439405;7230.891536626955;7266.63666816657;7266.7093316266755;7267.963660181666;7270.527415717961;1640.9917950410172;1734.4449776071535;1763.188933090767;1768.9115544222736;1769.5841477252836;1062.3785085724937;1124.1793490751797;1149.2989276541302;1150.620295302565;1154.284343706907;6721.529492935545;6737.8652426951185;6739.528233023641;6760.695768690421;6791;7428.62856857155;7459.104907411145;7462.216467270859;7462.664180111908;7471.103467583816;5825.359210486928;6472.805815825533;6740.090087838177;6754.628495432798;6758.8648227036165;3817.7518461300483;3889.5915928827067;3891.7859517726797;3935.2129574085297;3947.2697550953167;7686.692532298757;7738.342240909586;7741.806454838562;7745.7676269712;7746.690132394641;7598.164201937782;7618.314351708262;7619.580923049175;7620.542767433972;7624.466287359943;6290.150829638032;7724.6910123594425;7736.4584479085925;7753.534787912743;7767.067951845815;7169.820754481179;7287.708491660274;7391.667374968032;7392.778216653509;7403.7408690695565;7209.315115064061;7237.647764476461;7248.456365772694;7249.855002900018;7254.310840470147;7642.4650274480255;7688.500247483896;7698.34564062061;7703.191164927602;7709.8843517348405;4965.677230979974;4977.651564390603;4979.775910083982;4983.526564976321;4987.152184128634;7217.855642887218;7317.085364329459;7319.817004574928;7563.848723025619;7573.242675732383;7254.600996945219;7294.161171465349;7305.671244793891;7315.63421828917;7316.268373162641;5599.636023658449;6916.723331066701;7279.308465695751;7303.342699157101;7304.7078116876855;5904.760000399792;7124.073870397023;7133.750318739027;7144.928550714634;7157.105361829771;6851;6934.410575101173;7274.127104747464;7280.344768970606;7301.890471642823;6937.653117344012;6964.721411143701;7082;7095.113110861143;7097.6451177439885 02:37:10 INFO - PROCESS | 1945 | |5;yui.html;710.9608971506565;730.784418596514;779.0301075161425;800.6797281087564;802.9598520073997;15254.466093686724;15414.306356213969;15449.69100617987;15449.845501544982;15474.535763927071;13558.389872455738;14099.436022559084;14140.575782726535;14156.292185390716;14157.433702651908;783.8314762326099;963.2871674960548;980.8479685648736;982.9852552211722;985.0986347492036;974.7611835100375;985.7831277119058;990.1336330710628;993.9900600993969;994.184768489835;813.259933460551;1032.7521394865216;1037.7353774787418;1042.838360054193;1043.82776841821;1006.5168719014878;1031.1905154453755;1031.7265924530006;1033.6640591807693;1036.0934182590233;773.8413625206875;777.6811507282043;777.8327659553223;778.5056489129387;780.5238804329355;15238.314275857612;15274.465393711278;15326;15332.540023799304;15456.304466299043;12528.624141275777;12550.874491255061;12813.679658008625;13126.60620181396;13225.008124390613;10295.794084118275;10315.587376504931;10387.792244155151;10664.466776661213;11076.501557429934;3530.717542596586;3565.625609311011;3566.6433356664384;3625.854965801365;3800.6009369016133;83799.5810020946;83881.16118838795;84057;86396.56801715952;87014.56492717496;9594.568244429018;9608.13526782593;9735.56189971453;9760.804783904425;9805.117539421344;22491.66262506064;22516.774832251795;22527.43681407945;22529;22533.774662253167;7519.624018799038;7640.197779233212;7713.730019449293;7852.764417067498;8156.306713929263;4206.684498662613;4287.056847493546;4315.525292217853;4377.365282034088;4573.611243044378;3704.370257056307;3775.1505911169766;3775.2826962876966;3780.0360907968293;3781.054736315921;477.5320186217457;678.3555622158968;696.5159214345981;698.5250029979662;747.0624366420108;558.2714557502417;558.9636673616202;615.9928516874942;617.1298469158465;623.2396476298908;7969.681212751541;8181;8275.710350137717;8277.157093109285;8505.149485051445;590.447931184344;596.8239369386041;614.4193736918569;616.6119007086579;622.1414448061646;3837.65461108496;3840.2127563849344;3868.342381795045;3973.1854969731135;3977.025628720924;86201;86420;87423.56288218519;88460.6730899037;88491;75350.49299013989;75905.24094759092;76123.61938190385;77465.61267193628;78358.21641783623;66983.33016669868;67816;68430;69351.26621834494;73468.89796652948;8477.491350518989;8697.956510217662;8808.282384935132;8853.114688531095;8920.286377089948;47273.818154545035;47952.80117997078;49171.508284916694;49750.756231094514;50932.23601645904;43945.34081988837;67820;70859.29140708527;71301.6434917822;72649;9007.819843603222;11270.94364528172;11317.377544235145;11441.485133169193;11480.712982175512;11296.249081392398;11458.4270786462;12068.215565988183;12191.75616487683;12326.075544334031;8687.435316704394;11222.719432014264;11860.940695296813;11976.28142311464;12053.035757139583;11369.829452558053;11559.942200288944;11600.535978560763;11738.882611173778;11947.924686778231;11497.827532587185;11518;11699.707507312385;11759.294442333487;12080.275183489019;9757.21942244633;10043.74890627711;10061.245406594388;10110.79778404413;10317.896821031694;10135.138513226459;10175.949120254352;10189.592416303265;10195.694129176136;10197.439140847324 02:37:10 INFO - PROCESS | 1945 | __end_tp_report 02:37:10 INFO - PROCESS | 1945 | __start_cc_report 02:37:10 INFO - PROCESS | 1945 | _x_x_mozilla_cycle_collect,1133 02:37:10 INFO - PROCESS | 1945 | __end_cc_report 02:37:10 INFO - PROCESS | 1945 | __startTimestamp1469266630067__endTimestamp 02:37:10 INFO - PROCESS | 1945 | 02:37:10 INFO - PROCESS | 1945 | ------- Summary: start ------- 02:37:10 INFO - PROCESS | 1945 | Number of tests: 6 02:37:10 INFO - PROCESS | 1945 | 02:37:10 INFO - PROCESS | 1945 | [#0] dojo.html Cycles:165 Average:5960.56 Median:6225.84 stddev:639.17 (10.3%) stddev-sans-first:612.71 02:37:10 INFO - PROCESS | 1945 | Values: 3557.9 3604.0 3632.9 3650.6 3706.8 5992.5 6005.3 6010.8 6034.3 6062.4 6037.8 6068.7 6069.5 6075.1 6081.8 4628.6 5291.1 5381.5 5454.4 5508.2 5281.8 5483.6 5484.4 5489.6 5496.3 4529.6 5404.6 5413.0 5425.9 5449.8 5464.4 5483.4 5485.0 5511.7 5542.9 5315.5 5321.3 5371.3 5430.6 5445.0 5861.0 5866.3 5869.1 5875.6 5921.4 6291.9 6296.0 6311.1 6341.3 6354.4 5711.1 6326.3 6421.6 6427.1 6445.5 6144.2 6154.8 6163.9 6182.6 6195.2 6564.4 6582.9 6585.8 6603.0 6610.5 6216.8 6224.8 6297.7 6323.2 6326.1 6432.9 6445.1 6449.1 6449.6 6454.4 6231.2 6274.0 6284.6 6290.1 6296.8 6225.8 6251.1 6292.6 6301.5 6308.5 5099.7 5141.6 5149.2 5157.3 5166.3 4639.0 4669.6 4673.7 4679.9 4689.9 6015.7 6059.7 6136.1 6147.6 6149.4 6406.0 6408.9 6418.0 6435.0 6437.2 6098.8 6144.6 6163.0 6163.5 6167.1 5520.3 5533.6 5613.8 5620.0 5627.0 6600.2 6628.6 6642.7 6649.0 6695.6 6247.3 6380.4 6383.2 6392.7 6393.7 6568.0 6653.4 6679.2 6686.7 6689.0 6299.3 6318.5 6319.5 6320.7 6328.1 6238.4 6295.9 6348.4 6355.2 6460.2 6248.8 6278.9 6285.5 6296.5 6313.2 6278.6 6290.5 6290.5 6294.2 6296.2 6116.2 6116.2 6237.7 6249.2 6282.7 6169.2 6196.1 6228.4 6287.4 6313.6 6257.0 6266.1 6271.1 6277.1 6278.8 02:37:10 INFO - PROCESS | 1945 | 02:37:10 INFO - PROCESS | 1945 | [#1] ext.html Cycles:180 Average:62870.01 Median:187983.80 stddev:129568.67 (68.9%) stddev-sans-first:129847.57 02:37:10 INFO - PROCESS | 1945 | Values: 518.0 526.8 554.4 590.9 630.0 32352.4 32970.3 33024.8 33123.2 40112.4 43452.6 43926.6 44016.3 44035.8 44061.3 9490.6 9732.1 9735.3 9757.1 9765.0 9130.4 9557.6 9686.5 11709.4 11978.2 11455.4 11712.6 11820.6 11821.8 11823.1 10067.3 11627.6 11707.2 11804.8 11814.5 11600.8 11699.2 11707.4 11708.2 11709.1 40357.8 40751.8 42683.8 42766.4 42770.8 3255.7 3311.3 3315.5 3435.5 3447.4 27545.9 28362.0 28409.9 28410.9 28723.9 2721.0 2785.4 2814.4 2823.6 2881.2 341320.3 341746.3 342612.3 342616.0 348721.0 63271.4 69773.0 71474.0 71535.6 71769.3 67870.7 67892.7 67944.0 68125.6 68326.7 18237.6 18430.5 18451.9 18472.3 18490.4 13187.8 13813.2 13876.2 13921.1 14081.3 17953.6 20778.6 21298.9 21351.5 21371.9 7257.7 8012.9 8383.7 8462.7 8675.4 951.8 989.9 1026.0 1104.8 1129.3 24181.0 28769.7 28833.3 29089.9 29498.1 624.5 1100.7 1133.3 1156.5 1160.3 13645.7 14837.9 16163.8 16367.9 16540.5 631068.0 632837.0 645214.0 646472.0 647139.0 65279.0 65960.0 65975.4 66116.0 66300.3 1374.4 1391.9 1516.2 1552.6 1642.7 28799.4 30143.0 30178.5 30323.0 31055.7 52465.0 52658.5 53346.7 53378.7 53459.0 420381.0 423181.0 424067.9 425242.0 427144.0 24969.8 25435.7 28386.6 28787.3 29124.9 44526.6 47548.3 47874.0 48204.8 49259.0 37694.0 38950.0 39068.8 39222.6 40322.4 38208.2 38443.0 38667.8 39375.8 39451.0 38691.6 38762.5 39451.8 39536.2 39542.0 31939.4 33433.5 34154.8 34221.3 34451.0 22416.4 25523.9 25672.7 25795.9 25922.6 02:37:10 INFO - PROCESS | 1945 | 02:37:10 INFO - PROCESS | 1945 | [#2] jquery.html Cycles:180 Average:34990.38 Median:21016.55 stddev:101617.15 (483.5%) stddev-sans-first:101869.04 02:37:10 INFO - PROCESS | 1945 | Values: 410.5 412.8 413.0 415.6 421.5 20166.7 20545.9 21128.8 21289.1 21289.8 18063.4 21055.6 21376.3 22199.2 22208.0 5971.8 6016.3 6275.8 6277.6 6279.3 6154.4 6216.1 6237.5 6248.3 6248.5 5969.6 6231.9 6250.0 6255.6 6260.1 5142.3 6093.8 6119.1 6128.6 6224.6 5616.8 5947.5 5949.1 5968.6 5971.6 13462.7 13668.7 14056.2 14068.9 14080.0 2147.2 2154.9 2179.8 2504.8 2560.8 10020.3 10131.4 10208.3 10261.6 10517.1 1707.7 1722.2 1757.9 1770.9 1780.5 88305.0 111847.3 115607.0 116406.0 117943.4 11652.7 11893.2 12016.0 12107.2 12107.3 15439.8 15459.4 15484.8 15490.4 15498.2 9012.2 9094.5 9102.9 9191.6 9230.6 8977.3 8991.6 9015.1 9067.2 9136.4 4185.0 4659.2 4766.9 4790.8 4805.1 1665.0 2029.9 2040.7 2043.5 2070.0 909.8 944.7 1014.6 1037.4 1055.6 20466.0 20777.7 20978.8 21054.3 21132.6 999.9 1022.2 1025.8 1046.6 1101.0 11002.8 11408.8 11420.9 11463.5 11474.9 591920.0 596129.0 597929.0 625402.7 643223.0 116322.7 117530.0 118203.0 121611.8 124006.0 1015.8 1056.2 1062.0 1064.6 1085.1 18401.7 18850.3 19108.3 19156.5 19312.8 51448.5 53702.5 56181.0 57314.0 57407.1 79117.6 83085.6 83413.0 83715.0 85442.0 8033.5 8059.5 8467.7 8470.2 8497.2 10984.8 11163.4 12553.9 12898.5 13146.8 10771.7 10940.3 11319.9 11364.1 11378.1 9854.8 10309.7 10749.0 10938.6 11355.1 10923.5 11385.7 11457.0 11458.8 11700.9 8339.9 8430.3 8454.8 8630.8 8838.3 11194.9 11364.8 11555.7 11633.7 11741.2 02:37:10 INFO - PROCESS | 1945 | 02:37:10 INFO - PROCESS | 1945 | [#3] mootools.html Cycles:180 Average:5860.51 Median:4994.80 stddev:3269.49 (65.5%) stddev-sans-first:3261.55 02:37:10 INFO - PROCESS | 1945 | Values: 1410.8 1496.3 1643.0 1886.8 2065.9 8234.0 8962.5 9083.1 9135.3 9151.0 8806.6 9090.0 9110.0 9112.6 9116.3 2528.7 2551.1 2551.2 2555.6 2556.1 2209.3 2474.6 2481.5 2552.0 2553.9 2525.8 2536.3 2560.9 2561.7 2570.0 2508.7 2537.8 2546.3 2557.6 2567.3 2497.9 2538.1 2545.7 2548.5 2551.7 8892.7 9219.4 9275.9 9300.3 9310.2 5559.9 5712.1 5719.9 5766.4 5787.2 3666.8 3741.2 3786.2 3798.8 3818.6 1043.9 1061.1 1062.8 1075.3 1103.4 11990.6 12118.0 12388.0 12396.8 12404.3 4739.0 4781.1 4823.6 4828.1 4915.1 8147.6 8363.9 9675.4 9684.7 9725.0 5605.0 5610.7 5617.4 5619.2 5629.2 4662.3 4822.0 5070.4 5126.9 5230.7 4011.3 4071.9 4137.4 4141.2 4171.8 1283.7 1286.8 1287.9 1296.6 1299.7 869.8 914.8 947.7 948.5 958.2 5972.4 6091.8 6104.8 6144.9 6196.3 466.8 468.7 479.2 482.4 485.9 3966.7 3990.8 4024.9 4091.5 4124.9 10891.2 11292.0 11390.0 11458.3 11488.1 10441.7 10778.2 10928.2 11172.8 11175.8 8612.8 8649.4 8676.5 8725.6 8778.7 5769.2 6042.5 6106.8 6178.0 6261.1 9961.5 10170.3 10347.7 10351.0 10355.2 9500.6 9841.0 9883.4 9915.1 10082.2 7039.0 7193.5 7197.8 7758.7 7950.5 7897.7 8353.2 8561.6 8599.8 8616.4 7521.8 7644.0 7722.3 7736.9 7775.7 6292.7 7559.6 7567.4 7653.9 7678.9 7240.2 7293.0 7297.9 7298.0 7310.9 4680.8 4743.2 4910.7 4919.2 5113.3 5085.8 5098.9 5132.3 5154.5 5197.1 02:37:10 INFO - PROCESS | 1945 | 02:37:10 INFO - PROCESS | 1945 | [#4] prototype.html Cycles:180 Average:5912.27 Median:6666.90 stddev:1844.14 (27.7%) stddev-sans-first:1801.15 02:37:10 INFO - PROCESS | 1945 | Values: 333.8 340.6 344.5 351.6 352.9 5553.7 6593.2 6664.2 6740.0 6834.7 6500.6 6522.4 6669.6 6737.5 6739.6 4959.1 5019.9 5026.0 5048.5 5066.3 5053.6 5076.5 5096.0 5105.6 5112.4 4759.9 4856.9 5018.6 5024.4 5040.0 4999.4 5009.6 5026.9 5037.4 5046.3 3649.8 4209.6 4340.3 4343.7 4350.2 5208.7 6528.6 6529.5 6546.6 6566.4 5982.5 5994.4 5998.3 6023.7 6031.5 6106.5 6959.7 7182.5 7231.6 7239.2 4855.4 4884.3 4898.2 4900.2 4910.1 7543.5 7649.6 7652.4 7655.9 7660.2 4943.2 4950.0 4957.9 4969.0 4977.4 5040.9 5042.6 5045.9 5057.1 5060.1 5782.7 6000.0 6002.5 6011.2 6024.4 7230.9 7266.6 7266.7 7268.0 7270.5 1641.0 1734.4 1763.2 1768.9 1769.6 1062.4 1124.2 1149.3 1150.6 1154.3 6721.5 6737.9 6739.5 6760.7 6791.0 7428.6 7459.1 7462.2 7462.7 7471.1 5825.4 6472.8 6740.1 6754.6 6758.9 3817.8 3889.6 3891.8 3935.2 3947.3 7686.7 7738.3 7741.8 7745.8 7746.7 7598.2 7618.3 7619.6 7620.5 7624.5 6290.2 7724.7 7736.5 7753.5 7767.1 7169.8 7287.7 7391.7 7392.8 7403.7 7209.3 7237.6 7248.5 7249.9 7254.3 7642.5 7688.5 7698.3 7703.2 7709.9 4965.7 4977.7 4979.8 4983.5 4987.2 7217.9 7317.1 7319.8 7563.8 7573.2 7254.6 7294.2 7305.7 7315.6 7316.3 5599.6 6916.7 7279.3 7303.3 7304.7 5904.8 7124.1 7133.8 7144.9 7157.1 6851.0 6934.4 7274.1 7280.3 7301.9 6937.7 6964.7 7082.0 7095.1 7097.6 02:37:10 INFO - PROCESS | 1945 | 02:37:10 INFO - PROCESS | 1945 | [#5] yui.html Cycles:180 Average:18285.12 Median:24259.48 stddev:25333.75 (104.4%) stddev-sans-first:25370.45 02:37:10 INFO - PROCESS | 1945 | Values: 711.0 730.8 779.0 800.7 803.0 15254.5 15414.3 15449.7 15449.8 15474.5 13558.4 14099.4 14140.6 14156.3 14157.4 783.8 963.3 980.8 983.0 985.1 974.8 985.8 990.1 994.0 994.2 813.3 1032.8 1037.7 1042.8 1043.8 1006.5 1031.2 1031.7 1033.7 1036.1 773.8 777.7 777.8 778.5 780.5 15238.3 15274.5 15326.0 15332.5 15456.3 12528.6 12550.9 12813.7 13126.6 13225.0 10295.8 10315.6 10387.8 10664.5 11076.5 3530.7 3565.6 3566.6 3625.9 3800.6 83799.6 83881.2 84057.0 86396.6 87014.6 9594.6 9608.1 9735.6 9760.8 9805.1 22491.7 22516.8 22527.4 22529.0 22533.8 7519.6 7640.2 7713.7 7852.8 8156.3 4206.7 4287.1 4315.5 4377.4 4573.6 3704.4 3775.2 3775.3 3780.0 3781.1 477.5 678.4 696.5 698.5 747.1 558.3 559.0 616.0 617.1 623.2 7969.7 8181.0 8275.7 8277.2 8505.1 590.4 596.8 614.4 616.6 622.1 3837.7 3840.2 3868.3 3973.2 3977.0 86201.0 86420.0 87423.6 88460.7 88491.0 75350.5 75905.2 76123.6 77465.6 78358.2 66983.3 67816.0 68430.0 69351.3 73468.9 8477.5 8698.0 8808.3 8853.1 8920.3 47273.8 47952.8 49171.5 49750.8 50932.2 43945.3 67820.0 70859.3 71301.6 72649.0 9007.8 11270.9 11317.4 11441.5 11480.7 11296.2 11458.4 12068.2 12191.8 12326.1 8687.4 11222.7 11860.9 11976.3 12053.0 11369.8 11559.9 11600.5 11738.9 11947.9 11497.8 11518.0 11699.7 11759.3 12080.3 9757.2 10043.7 10061.2 10110.8 10317.9 10135.1 10175.9 10189.6 10195.7 10197.4 02:37:10 INFO - PROCESS | 1945 | -------- Summary: end -------- 02:37:10 INFO - PROCESS | 1945 | 02:37:10 INFO - TEST-INFO | 1945: exit 0 02:37:10 INFO - TEST-OK | dromaeo_css | took 1113036ms 02:37:10 INFO - TEST-START | kraken 02:37:10 INFO - operating with platform_type : mac_ 02:37:10 INFO - Initialising browser for kraken test... 02:37:10 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpoZ86d5/profile http://localhost:52294/getInfo.html) 02:37:12 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 02:37:12 INFO - PROCESS | 1949 | colorDepth:24 02:37:12 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 02:37:12 INFO - PROCESS | 1949 | __metrics 02:37:12 INFO - PROCESS | 1949 | 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" 02:37:12 ERROR - PROCESS | 1949 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:37:13 INFO - TEST-INFO | 1949: exit 0 02:37:13 INFO - Browser initialized. 02:37:13 INFO - Running cycle 1/1 for kraken test... 02:37:13 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpoZ86d5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:25 INFO - PROCESS | 1952 | RSS: Main: 160399360 02:37:25 INFO - PROCESS | 1952 | 02:37:27 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52294/tests/kraken/driver.html?testName=audio-beat-detection) 02:37:28 INFO - PROCESS | 1952 | RSS: Main: 224022528 02:37:28 INFO - PROCESS | 1952 | 02:37:31 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52294/tests/kraken/driver.html?testName=audio-dft) 02:37:32 INFO - PROCESS | 1952 | RSS: Main: 239702016 02:37:32 INFO - PROCESS | 1952 | 02:37:35 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52294/tests/kraken/driver.html?testName=audio-fft) 02:37:35 INFO - PROCESS | 1952 | RSS: Main: 326504448 02:37:35 INFO - PROCESS | 1952 | 02:37:37 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52294/tests/kraken/driver.html?testName=audio-oscillator) 02:37:38 INFO - PROCESS | 1952 | RSS: Main: 231419904 02:37:38 INFO - PROCESS | 1952 | 02:37:40 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52294/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:37:41 INFO - PROCESS | 1952 | RSS: Main: 232181760 02:37:41 INFO - PROCESS | 1952 | 02:37:44 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52294/tests/kraken/driver.html?testName=imaging-darkroom) 02:37:45 INFO - PROCESS | 1952 | RSS: Main: 271253504 02:37:45 INFO - PROCESS | 1952 | 02:37:47 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52294/tests/kraken/driver.html?testName=imaging-desaturate) 02:37:48 INFO - PROCESS | 1952 | RSS: Main: 269520896 02:37:48 INFO - PROCESS | 1952 | 02:37:51 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52294/tests/kraken/driver.html?testName=json-parse-financial) 02:37:51 INFO - PROCESS | 1952 | RSS: Main: 268292096 02:37:51 INFO - PROCESS | 1952 | 02:37:53 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52294/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:37:54 INFO - PROCESS | 1952 | RSS: Main: 260907008 02:37:54 INFO - PROCESS | 1952 | 02:37:55 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52294/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:37:56 INFO - PROCESS | 1952 | RSS: Main: 267218944 02:37:56 INFO - PROCESS | 1952 | 02:37:58 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52294/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:37:59 INFO - PROCESS | 1952 | RSS: Main: 271286272 02:37:59 INFO - PROCESS | 1952 | 02:38:01 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:38:02 INFO - PROCESS | 1952 | RSS: Main: 278528000 02:38:02 INFO - PROCESS | 1952 | 02:38:05 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:38:06 INFO - PROCESS | 1952 | RSS: Main: 275431424 02:38:06 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:52294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52294/tests/kraken/driver.html?testName=ai-astar) 02:38:07 INFO - PROCESS | 1952 | RSS: Main: 336674816 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | __start_tp_report 02:38:07 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 02:38:07 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 02:38:07 INFO - PROCESS | 1952 | |i|pagename|runs| 02:38:07 INFO - PROCESS | 1952 | |0;ai-astar;114;113;119;111;112;112;116;112;114;131 02:38:07 INFO - PROCESS | 1952 | |1;audio-beat-detection;154;120;145;169;121;143;118;150;157;120 02:38:07 INFO - PROCESS | 1952 | |2;audio-dft;187;185;184;184;187;187;183;184;183;186 02:38:07 INFO - PROCESS | 1952 | |3;audio-fft;70;78;72;156;83;85;89;65;133;58 02:38:07 INFO - PROCESS | 1952 | |4;audio-oscillator;93;91;141;79;79;88;120;108;114;167 02:38:07 INFO - PROCESS | 1952 | |5;imaging-gaussian-blur;87;84;89;128;134;84;88;90;136;111 02:38:07 INFO - PROCESS | 1952 | |6;imaging-darkroom;93;92;92;91;97;95;93;92;96;92 02:38:07 INFO - PROCESS | 1952 | |7;imaging-desaturate;84;84;83;85;85;95;139;132;86;86 02:38:07 INFO - PROCESS | 1952 | |8;json-parse-financial;58;63;62;62;62;64;64;81;59;56 02:38:07 INFO - PROCESS | 1952 | |9;json-stringify-tinderbox;61;63;61;72;73;69;66;66;66;67 02:38:07 INFO - PROCESS | 1952 | |10;stanford-crypto-aes;80;80;79;80;80;80;79;80;79;83 02:38:07 INFO - PROCESS | 1952 | |11;stanford-crypto-ccm;154;139;142;123;124;125;123;126;144;136 02:38:07 INFO - PROCESS | 1952 | |12;stanford-crypto-pbkdf2;164;160;163;162;166;166;162;163;165;160 02:38:07 INFO - PROCESS | 1952 | |13;stanford-crypto-sha256-iterative;66;66;69;67;67;66;67;71;64;57 02:38:07 INFO - PROCESS | 1952 | __end_tp_report 02:38:07 INFO - PROCESS | 1952 | __start_cc_report 02:38:07 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,1940 02:38:07 INFO - PROCESS | 1952 | __end_cc_report 02:38:07 INFO - PROCESS | 1952 | __startTimestamp1469266687947__endTimestamp 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | ------- Summary: start ------- 02:38:07 INFO - PROCESS | 1952 | Number of tests: 14 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#0] ai-astar Cycles:10 Average:115.40 Median:114.00 stddev:5.97 (5.2%) stddev-sans-first:6.31 02:38:07 INFO - PROCESS | 1952 | Values: 114.0 113.0 119.0 111.0 112.0 112.0 116.0 112.0 114.0 131.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:147.50 stddev:18.57 (12.6%) stddev-sans-first:18.96 02:38:07 INFO - PROCESS | 1952 | Values: 154.0 120.0 145.0 169.0 121.0 143.0 118.0 150.0 157.0 120.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.50 stddev:1.63 (0.9%) stddev-sans-first:1.56 02:38:07 INFO - PROCESS | 1952 | Values: 187.0 185.0 184.0 184.0 187.0 187.0 183.0 184.0 183.0 186.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#3] audio-fft Cycles:10 Average:88.90 Median:75.00 stddev:31.24 (41.7%) stddev-sans-first:32.38 02:38:07 INFO - PROCESS | 1952 | Values: 70.0 78.0 72.0 156.0 83.0 85.0 89.0 65.0 133.0 58.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:79.00 stddev:28.57 (36.2%) stddev-sans-first:29.78 02:38:07 INFO - PROCESS | 1952 | Values: 93.0 91.0 141.0 79.0 79.0 88.0 120.0 108.0 114.0 167.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:85.50 stddev:21.88 (25.6%) stddev-sans-first:22.41 02:38:07 INFO - PROCESS | 1952 | Values: 87.0 84.0 89.0 128.0 134.0 84.0 88.0 90.0 136.0 111.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:2.00 (2.2%) stddev-sans-first:2.12 02:38:07 INFO - PROCESS | 1952 | Values: 93.0 92.0 92.0 91.0 97.0 95.0 93.0 92.0 96.0 92.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:85.00 stddev:21.20 (24.9%) stddev-sans-first:22.04 02:38:07 INFO - PROCESS | 1952 | Values: 84.0 84.0 83.0 85.0 85.0 95.0 139.0 132.0 86.0 86.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:62.50 stddev:6.82 (10.9%) stddev-sans-first:6.98 02:38:07 INFO - PROCESS | 1952 | Values: 58.0 63.0 62.0 62.0 62.0 64.0 64.0 81.0 59.0 56.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:4.12 (6.2%) stddev-sans-first:3.87 02:38:07 INFO - PROCESS | 1952 | Values: 61.0 63.0 61.0 72.0 73.0 69.0 66.0 66.0 66.0 67.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.15 (1.4%) stddev-sans-first:1.22 02:38:07 INFO - PROCESS | 1952 | Values: 80.0 80.0 79.0 80.0 80.0 80.0 79.0 80.0 79.0 83.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:137.50 stddev:10.95 (8.0%) stddev-sans-first:8.77 02:38:07 INFO - PROCESS | 1952 | Values: 154.0 139.0 142.0 123.0 124.0 125.0 123.0 126.0 144.0 136.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.50 stddev:2.18 (1.3%) stddev-sans-first:2.29 02:38:07 INFO - PROCESS | 1952 | Values: 164.0 160.0 163.0 162.0 166.0 166.0 162.0 163.0 165.0 160.0 02:38:07 INFO - PROCESS | 1952 | 02:38:07 INFO - PROCESS | 1952 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:67.00 stddev:3.68 (5.5%) stddev-sans-first:3.91 02:38:07 INFO - PROCESS | 1952 | Values: 66.0 66.0 69.0 67.0 67.0 66.0 67.0 71.0 64.0 57.0 02:38:07 INFO - PROCESS | 1952 | -------- Summary: end -------- 02:38:07 INFO - PROCESS | 1952 | 02:38:08 INFO - TEST-INFO | 1952: exit 0 02:38:08 INFO - TEST-OK | kraken | took 58295ms 02:38:08 INFO - SUITE-END | took 1171s 02:38:09 INFO - Completed test suite (00:19:31) 02:38:09 INFO - javascript benchmark 02:38:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3557.9288414231714, 3604.0, 3632.9273414531704, 3650.5984341722424, 3706.7775933443995, 5992.490638295744, 6005.309389420218, 6010.8196754097335, 6034.332411490649, 6062.363451837559, 6037.849053773658, 6068.6965651717455, 6069.4840938520165, 6075.149479072933, 6081.847953801157, 4628.560286772751, 5291.126964050927, 5381.54256888164, 5454.372747134091, 5508.228847961269, 5281.841544753664, 5483.561315094803, 5484.369297530795, 5489.58828087895, 5496.340439147308, 4529.614982726473, 5404.594655400841, 5412.972935135338, 5425.945740542603, 5449.836504904859, 5464.371597266306, 5483.369412517532, 5485.0, 5511.696856672881, 5542.944570554283, 5315.495027972375, 5321.308229930123, 5371.328583927009, 5430.619856610039, 5445.019896418683, 5861.003629382973, 5866.325372582165, 5869.1196320551835, 5875.647461152302, 5921.407859214044, 6291.937080629226, 6295.96852015737, 6311.084892690534, 6341.270753863272, 6354.364563543655, 5711.114777209539, 6326.304106548322, 6421.550491465599, 6427.132337134521, 6445.484361251136, 6144.170536977451, 6154.753809847601, 6163.876722465526, 6182.567220294626, 6195.16365290689, 6564.376384243489, 6582.934170658328, 6585.835354116185, 6603.042558828943, 6610.504212184105, 6216.782412615627, 6224.844378890564, 6297.748090076346, 6323.241211054703, 6326.114343991845, 6432.935670643327, 6445.097686323918, 6449.064885591657, 6449.645269510222, 6454.354564543602, 6231.158793562901, 6274.027525733519, 6284.591501552384, 6290.119383286344, 6296.811095667137, 6225.844353891099, 6251.062340648939, 6292.559520833589, 6301.464375528039, 6308.495320374359, 5099.745012749348, 5141.562967147835, 5149.150390185652, 5157.329547158845, 5166.302549155891, 4639.0, 4669.579737823544, 4673.696209746356, 4679.859604211879, 4689.906201875943, 6015.699215039231, 6059.697015149225, 6136.140940268366, 6147.5553244987395, 6149.41580549847, 6406.007068904327, 6408.935910640834, 6418.037294405876, 6435.0, 6437.195350581177, 6098.847528811726, 6144.569880108439, 6162.969185154046, 6163.476104531075, 6167.074938759222, 5520.254765606672, 5533.6403133796175, 5613.831585052455, 5620.016497112989, 5626.971865140648, 6600.174978127734, 6628.5691430056895, 6642.734290628514, 6648.96675516629, 6695.598264104169, 6247.281562620356, 6380.425761681471, 6383.234011918599, 6392.712327945161, 6393.744250229939, 6567.9671601641685, 6653.401193892573, 6679.198496180489, 6686.69909854048, 6688.966555167193, 6299.338569450142, 6318.494520438446, 6319.494440444845, 6320.652364119834, 6328.082428047999, 6238.438540531374, 6295.905561416674, 6348.428641422294, 6355.237371515448, 6460.160179176677, 6248.781292654735, 6278.874422511615, 6285.528585356025, 6296.496280297657, 6313.210848643919, 6278.591891527219, 6290.496760259077, 6290.528210384331, 6294.15028971083, 6296.181496405438, 6116.235470566179, 6116.244470650343, 6237.719302631302, 6249.218847644044, 6282.654454005074, 6169.2288463942, 6196.1015652731, 6228.439440450381, 6287.434130928238, 6313.589616674902, 6257.0, 6266.122742816101, 6271.059341098689, 6277.12120303167, 6278.811635650938], "value": 5921.542102241111, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.9689218646881, 526.8340472751083, 554.3846330573065, 590.9438603332685, 630.0077378129447, 32352.352952940928, 32970.34059318812, 33024.83487582562, 33123.17192070199, 40112.39831402531, 43452.56547434525, 43926.560734392646, 44016.3397549037, 44035.77982110085, 44061.33907991383, 9490.620375185, 9732.07545283197, 9735.318527703064, 9757.121859032686, 9765.0, 9130.360874738772, 9557.56990935406, 9686.515674216296, 11709.355985420798, 11978.221415608, 11455.427228638577, 11712.590059347924, 11820.645380638594, 11821.7635647287, 11823.113266505003, 10067.345622534513, 11627.59303424376, 11707.180497365187, 11804.822927656092, 11814.468348924276, 11600.825987610193, 11699.18105732599, 11707.356095414749, 11708.238964467282, 11709.121815863844, 40357.79821100905, 40751.7962410189, 42683.78658106721, 42766.358504622454, 42770.78614606907, 3255.6581558936446, 3311.2549676322874, 3315.4529502632035, 3435.4846772984, 3447.379471695094, 27545.898164073413, 28362.007329743567, 28409.85795071032, 28410.857945710344, 28723.856380717963, 2720.9591856122174, 2785.373291009527, 2814.4230432761233, 2823.5905793659804, 2881.236472334833, 341320.29339853144, 341746.29126854456, 342612.2869385662, 342616.0, 348721.0, 63271.36728632747, 69773.0, 71474.0, 71535.56928861393, 71769.2823071773, 67870.66064669644, 67892.660536697, 67944.0, 68125.61560345364, 68326.65836670884, 18237.635247295246, 18430.539236518925, 18451.90774046121, 18472.261109555468, 18490.352837650888, 13187.802182967263, 13813.171209727248, 13876.236806975714, 13921.095128816796, 14081.2959352032, 17953.640927181383, 20778.584428311653, 21298.893505532684, 21351.46621334448, 21371.893140534197, 7257.745978890714, 8012.879806802903, 8383.706570270133, 8462.746117616482, 8675.436096653697, 951.7620594851287, 989.8663680403198, 1025.9692209233735, 1104.8287515434959, 1129.3280498103616, 24181.0, 28769.71230287712, 28833.279168020967, 29089.854550727112, 29498.115056547907, 624.5316012990257, 1100.6697990602788, 1133.3426612564692, 1156.5373850459882, 1160.3444054109402, 13645.727085458235, 14837.851621483647, 16163.757543636855, 16367.91816040912, 16540.503784886474, 631068.0, 632837.0, 645214.0, 646472.0, 647139.0, 65279.0, 65960.01059984104, 65975.37135457499, 66116.0, 66300.33699662941, 1374.4227424481742, 1391.8956078294168, 1516.1812621184438, 1552.6428921347926, 1642.6714657068635, 28799.42401152007, 30143.0, 30178.547321789752, 30323.0, 31055.689443106185, 52465.0, 52658.473415265355, 53346.73326633497, 53378.73310633422, 53459.0, 420381.0, 423181.0, 424067.87966059975, 425242.0, 427144.0, 24969.75030249674, 25435.745642543337, 28386.574201386582, 28787.28031799222, 29124.854375727984, 44526.55473445354, 47548.28677569908, 47874.04251915012, 48204.758976204896, 49259.0, 37694.0, 38950.0, 39068.804655976535, 39222.60777392304, 40322.395164071975, 38208.235835283696, 38443.038924027125, 38667.80666096652, 39375.80312098421, 39451.0, 38691.613083869925, 38762.49423914619, 39451.80274098611, 39536.209275813744, 39542.0, 31939.36121277608, 33433.49849752207, 34154.80458183952, 34221.31557368889, 34451.0, 22416.43454039036, 25523.87238063872, 25672.743272567037, 25795.871020644776, 25922.61116083298], "value": 20380.043188187952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.46895081346577, 412.84931000184935, 412.9731567448114, 415.60725114766547, 421.49631190727075, 20166.672499037642, 20545.86997715125, 21128.788712112873, 21289.148434062638, 21289.787102128976, 18063.36778212763, 21055.578888422224, 21376.251831185913, 22199.22302719405, 22208.0, 5971.790987315456, 6016.338202797689, 6275.811725648238, 6277.560570760049, 6279.34066922971, 6154.384561543855, 6216.098665693472, 6237.500999920018, 6248.31268560458, 6248.468880145193, 5969.5821292509545, 6231.875362492748, 6250.0, 6255.59338642989, 6260.123582698426, 5142.305788718512, 6093.786717464912, 6119.051547010198, 6128.57100003, 6224.595401298901, 5616.831495055155, 5947.524198064145, 5949.107633854913, 5968.641881487081, 5971.581989260753, 13462.730745385135, 13668.726625467534, 14056.226907520082, 14068.859311406959, 14080.014398992074, 2147.1733382647635, 2154.9245776397906, 2179.8256139508803, 2504.8371855829314, 2560.7823335016546, 10020.34867733595, 10131.392116473035, 10208.336458130198, 10261.640842570474, 10517.1060459861, 1707.743838424234, 1722.2249987505547, 1757.850582700472, 1770.9026003569797, 1780.4569606270084, 88305.0, 111847.32229016571, 115607.0, 116406.0, 117943.41028294804, 11652.650420487398, 11893.226940248856, 12016.0, 12107.213031152947, 12107.273563586214, 15439.768403473958, 15459.381624734884, 15484.845151548565, 15490.380384784708, 15498.225088745517, 9012.188902998761, 9094.545272736468, 9102.86345704815, 9191.586378612978, 9230.630774769068, 8977.32670049749, 8991.640334386682, 9015.14356136166, 9067.229285510673, 9136.406133601295, 4185.0, 4659.161350956861, 4766.880827979328, 4790.760461976887, 4805.111054454937, 1664.9750253746204, 2029.9391018269475, 2040.6734922412343, 2043.540203454211, 2069.9793002070087, 909.7862002429424, 944.6504793226413, 1014.6398028699853, 1037.4138611684375, 1055.6358056470506, 20465.976701164884, 20777.688334674993, 20978.79021209799, 21054.315494788352, 21132.577348452945, 999.9150072243941, 1022.2026819081128, 1025.7692019295748, 1046.612753281291, 1100.9559617615205, 11002.834957475645, 11408.828867566826, 11420.94289528547, 11463.45243392148, 11474.87714772753, 591920.0, 596129.0, 597929.0, 625402.7459725436, 643223.0, 116322.67354653029, 117530.0, 118203.0, 121611.78388216182, 124006.0, 1015.8374660054355, 1056.2025670618634, 1062.0335494699787, 1064.6273804168634, 1085.1318944844093, 18401.72397414013, 18850.3402380916, 19108.33120840764, 19156.521086972938, 19312.8068719311, 51448.48551514437, 53702.462975369745, 56181.0, 57314.0, 57407.13889291747, 79117.60441197758, 83085.58457207675, 83413.0, 83715.0, 85442.0, 8033.517988920684, 8059.516429014044, 8467.745967620982, 8470.237678608955, 8497.192766687154, 10984.780304394028, 11163.44182790841, 12553.93723031379, 12898.48406063747, 13146.802797957847, 10771.730706732395, 10940.343579385262, 11319.886801131883, 11364.147688923198, 11378.08975281992, 9854.802903942025, 10309.659744233202, 10749.0, 10938.56245750161, 11355.148363872908, 10923.508442119964, 11385.715357116138, 11457.026152777107, 11458.77082458363, 11700.88299116998, 8339.874901876598, 8430.283425908867, 8454.816325714282, 8630.82738345242, 8838.292936565187, 11194.888051119384, 11364.829527556927, 11555.711107222387, 11633.709157271136, 11741.236819606698], "value": 9664.686204497373, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.7672234081376, 1496.2967405319496, 1642.9753553696694, 1886.7924528301894, 2065.9276925307618, 8234.011918569773, 8962.507062111581, 9083.091690830914, 9135.269178465724, 9151.0, 8806.64773409063, 9090.0, 9110.0, 9112.635494580209, 9116.270698344133, 2528.747125287475, 2551.081610620175, 2551.1963731424635, 2555.56555385584, 2556.0670355320267, 2209.2709405896017, 2474.591692370757, 2481.5161043596504, 2552.0302285131625, 2553.872306384683, 2525.7979361651023, 2536.2771610091127, 2560.8591527465983, 2561.7310182430856, 2570.0362364113457, 2508.7240403555684, 2537.8096642751775, 2546.2997675639162, 2557.6419301297647, 2567.332493551671, 2497.8501289922665, 2538.1497198438547, 2545.7072436669837, 2548.5157820014324, 2551.7496426750945, 8892.73321800347, 9219.35464517484, 9275.860862087075, 9300.302477314228, 9310.208632266265, 5559.861003474945, 5712.057510510761, 5719.942800571983, 5766.394528574523, 5787.1608616750755, 3666.7983260920637, 3741.2330472253393, 3786.2238241160494, 3798.7530810497506, 3818.6372294631965, 1043.8903915088958, 1061.1245722279073, 1062.8352605346106, 1075.3494136047734, 1103.426218366445, 11990.580329688506, 12118.0, 12388.0, 12396.81404778929, 12404.317762523058, 4738.976305118521, 4781.091592597395, 4823.5658790709, 4828.082664293773, 4915.090708218991, 8147.592620368958, 8363.874541881876, 9675.371100878421, 9684.70945871625, 9724.95137524308, 5605.0, 5610.663360198401, 5617.43825617435, 5619.241402410704, 5629.183768353566, 4662.300654901792, 4821.951780482221, 5070.391553013662, 5126.92309615356, 5230.738463076831, 4011.3180759270995, 4071.9389209161886, 4137.379393091061, 4141.171765646883, 4171.83312667496, 1283.6598301450124, 1286.8455785305823, 1287.8776516230944, 1296.623979046085, 1299.7140629061591, 869.8216865542676, 914.8216097860986, 947.6683160893632, 948.4878165790534, 958.242988039441, 5972.432618901197, 6091.8172454825535, 6104.847378815565, 6144.8771024580155, 6196.256449226122, 466.7642840365594, 468.6953480237873, 479.19256053549185, 482.4210946863777, 485.9198232291703, 3966.662833659171, 3990.780507072081, 4024.879253622396, 4091.5499295077516, 4124.876253712393, 10891.183161262938, 11291.983721464943, 11390.0, 11458.255213411101, 11488.138389620812, 10441.738956526147, 10778.245522813328, 10928.180386471047, 11172.832407513893, 11175.776484470265, 8612.827743445096, 8649.394542381973, 8676.479411235347, 8725.607347669371, 8778.736637901002, 5769.192313076089, 6042.516598672184, 6106.755729770759, 6177.96911015442, 6261.123442718114, 9961.50192490387, 10170.338927969658, 10347.689569312932, 10351.016653417913, 10355.171586272929, 9500.572474238814, 9841.0, 9883.357581757164, 9915.107640312406, 10082.193424525874, 7039.0, 7193.4604904631315, 7197.820054498679, 7758.68965241384, 7950.4832185907735, 7897.723579674684, 8353.164683531599, 8561.57192140378, 8599.796028555882, 8616.396852220285, 7521.849563008818, 7643.961780191064, 7722.343600793995, 7736.878152667944, 7775.650095745818, 6292.716827742671, 7559.622018899143, 7567.432442566719, 7653.923460765321, 7678.923210768045, 7240.239774823778, 7293.0, 7297.927020729937, 7298.0, 7310.890336645061, 4680.836170734008, 4743.193657078236, 4910.729909854992, 4919.2129259318335, 5113.335266415491, 5085.847424577269, 5098.923516147187, 5132.281480592795, 5154.484551544965, 5197.0905091608065], "value": 4653.605601467853, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.8116305950815, 340.63981042654035, 344.4626382842765, 351.55879371388903, 352.8676746220166, 5553.722313884305, 6593.175853018372, 6664.166979127615, 6739.955306927422, 6834.658267086638, 6500.609963402199, 6522.445592124664, 6669.633170175651, 6737.528373013891, 6739.561928474645, 4959.107360675077, 5019.945811379596, 5026.045051440233, 5048.469910659383, 5066.316047333618, 5053.64624476285, 5076.492350764913, 5095.980803839228, 5105.591552675795, 5112.41207261166, 4759.90480190396, 4856.935802284032, 5018.573421259179, 5024.371953505812, 5039.974800126012, 4999.400071991385, 5009.599232061426, 5026.924596131061, 5037.4458809530925, 5046.293518907356, 3649.7810131391934, 4209.621134097915, 4340.262155433584, 4343.717658352197, 4350.216960947028, 5208.687478751249, 6528.608283502957, 6529.5429319947625, 6546.639934803584, 6566.376194261537, 5982.461578457916, 5994.400559944014, 5998.340182579913, 6023.698815059273, 6031.487323577501, 6106.48094911933, 6959.6868140933775, 7182.533135346186, 7231.602261875595, 7239.20368759436, 4855.368802055746, 4884.267359896008, 4898.2162853943555, 4900.191468407708, 4910.116179087763, 7543.547387156788, 7649.617519124022, 7652.426068044919, 7655.885161722578, 7660.195679453688, 4943.1596628573225, 4950.009998000414, 4957.925631115536, 4968.975155124202, 4977.402711674622, 5040.899182016339, 5042.596592272609, 5045.949540504622, 5057.064443078042, 5060.114479965991, 5782.710864456761, 6000.0, 6002.459778619857, 6011.218541589653, 6024.3975602439405, 7230.891536626955, 7266.63666816657, 7266.7093316266755, 7267.963660181666, 7270.527415717961, 1640.9917950410172, 1734.4449776071535, 1763.188933090767, 1768.9115544222736, 1769.5841477252836, 1062.3785085724937, 1124.1793490751797, 1149.2989276541302, 1150.620295302565, 1154.284343706907, 6721.529492935545, 6737.8652426951185, 6739.528233023641, 6760.695768690421, 6791.0, 7428.62856857155, 7459.104907411145, 7462.216467270859, 7462.664180111908, 7471.103467583816, 5825.359210486928, 6472.805815825533, 6740.090087838177, 6754.628495432798, 6758.8648227036165, 3817.7518461300483, 3889.5915928827067, 3891.7859517726797, 3935.2129574085297, 3947.2697550953167, 7686.692532298757, 7738.342240909586, 7741.806454838562, 7745.7676269712, 7746.690132394641, 7598.164201937782, 7618.314351708262, 7619.580923049175, 7620.542767433972, 7624.466287359943, 6290.150829638032, 7724.6910123594425, 7736.4584479085925, 7753.534787912743, 7767.067951845815, 7169.820754481179, 7287.708491660274, 7391.667374968032, 7392.778216653509, 7403.7408690695565, 7209.315115064061, 7237.647764476461, 7248.456365772694, 7249.855002900018, 7254.310840470147, 7642.4650274480255, 7688.500247483896, 7698.34564062061, 7703.191164927602, 7709.8843517348405, 4965.677230979974, 4977.651564390603, 4979.775910083982, 4983.526564976321, 4987.152184128634, 7217.855642887218, 7317.085364329459, 7319.817004574928, 7563.848723025619, 7573.242675732383, 7254.600996945219, 7294.161171465349, 7305.671244793891, 7315.63421828917, 7316.268373162641, 5599.636023658449, 6916.723331066701, 7279.308465695751, 7303.342699157101, 7304.7078116876855, 5904.760000399792, 7124.073870397023, 7133.750318739027, 7144.928550714634, 7157.105361829771, 6851.0, 6934.410575101173, 7274.127104747464, 7280.344768970606, 7301.890471642823, 6937.653117344012, 6964.721411143701, 7082.0, 7095.113110861143, 7097.6451177439885], "value": 5301.042195024279, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.9608971506565, 730.784418596514, 779.0301075161425, 800.6797281087564, 802.9598520073997, 15254.466093686724, 15414.306356213969, 15449.69100617987, 15449.845501544982, 15474.535763927071, 13558.389872455738, 14099.436022559084, 14140.575782726535, 14156.292185390716, 14157.433702651908, 783.8314762326099, 963.2871674960548, 980.8479685648736, 982.9852552211722, 985.0986347492036, 974.7611835100375, 985.7831277119058, 990.1336330710628, 993.9900600993969, 994.184768489835, 813.259933460551, 1032.7521394865216, 1037.7353774787418, 1042.838360054193, 1043.82776841821, 1006.5168719014878, 1031.1905154453755, 1031.7265924530006, 1033.6640591807693, 1036.0934182590233, 773.8413625206875, 777.6811507282043, 777.8327659553223, 778.5056489129387, 780.5238804329355, 15238.314275857612, 15274.465393711278, 15326.0, 15332.540023799304, 15456.304466299043, 12528.624141275777, 12550.874491255061, 12813.679658008625, 13126.60620181396, 13225.008124390613, 10295.794084118275, 10315.587376504931, 10387.792244155151, 10664.466776661213, 11076.501557429934, 3530.717542596586, 3565.625609311011, 3566.6433356664384, 3625.854965801365, 3800.6009369016133, 83799.5810020946, 83881.16118838795, 84057.0, 86396.56801715952, 87014.56492717496, 9594.568244429018, 9608.13526782593, 9735.56189971453, 9760.804783904425, 9805.117539421344, 22491.66262506064, 22516.774832251795, 22527.43681407945, 22529.0, 22533.774662253167, 7519.624018799038, 7640.197779233212, 7713.730019449293, 7852.764417067498, 8156.306713929263, 4206.684498662613, 4287.056847493546, 4315.525292217853, 4377.365282034088, 4573.611243044378, 3704.370257056307, 3775.1505911169766, 3775.2826962876966, 3780.0360907968293, 3781.054736315921, 477.5320186217457, 678.3555622158968, 696.5159214345981, 698.5250029979662, 747.0624366420108, 558.2714557502417, 558.9636673616202, 615.9928516874942, 617.1298469158465, 623.2396476298908, 7969.681212751541, 8181.0, 8275.710350137717, 8277.157093109285, 8505.149485051445, 590.447931184344, 596.8239369386041, 614.4193736918569, 616.6119007086579, 622.1414448061646, 3837.65461108496, 3840.2127563849344, 3868.342381795045, 3973.1854969731135, 3977.025628720924, 86201.0, 86420.0, 87423.56288218519, 88460.6730899037, 88491.0, 75350.49299013989, 75905.24094759092, 76123.61938190385, 77465.61267193628, 78358.21641783623, 66983.33016669868, 67816.0, 68430.0, 69351.26621834494, 73468.89796652948, 8477.491350518989, 8697.956510217662, 8808.282384935132, 8853.114688531095, 8920.286377089948, 47273.818154545035, 47952.80117997078, 49171.508284916694, 49750.756231094514, 50932.23601645904, 43945.34081988837, 67820.0, 70859.29140708527, 71301.6434917822, 72649.0, 9007.819843603222, 11270.94364528172, 11317.377544235145, 11441.485133169193, 11480.712982175512, 11296.249081392398, 11458.4270786462, 12068.215565988183, 12191.75616487683, 12326.075544334031, 8687.435316704394, 11222.719432014264, 11860.940695296813, 11976.28142311464, 12053.035757139583, 11369.829452558053, 11559.942200288944, 11600.535978560763, 11738.882611173778, 11947.924686778231, 11497.827532587185, 11518.0, 11699.707507312385, 11759.294442333487, 12080.275183489019, 9757.21942244633, 10043.74890627711, 10061.245406594388, 10110.79778404413, 10317.896821031694, 10135.138513226459, 10175.949120254352, 10189.592416303265, 10195.694129176136, 10197.439140847324], "value": 7098.594230004122, "unit": "score"}], "name": "dromaeo_css", "value": 7674.16655783639, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 119.0, 111.0, 112.0, 112.0, 116.0, 112.0, 114.0, 131.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 145.0, 169.0, 121.0, 143.0, 118.0, 150.0, 157.0, 120.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 184.0, 184.0, 187.0, 187.0, 183.0, 184.0, 183.0, 186.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 72.0, 156.0, 83.0, 85.0, 89.0, 65.0, 133.0, 58.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 141.0, 79.0, 79.0, 88.0, 120.0, 108.0, 114.0, 167.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 89.0, 128.0, 134.0, 84.0, 88.0, 90.0, 136.0, 111.0], "value": 103.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 92.0, 91.0, 97.0, 95.0, 93.0, 92.0, 96.0, 92.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 85.0, 85.0, 95.0, 139.0, 132.0, 86.0, 86.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 62.0, 62.0, 62.0, 64.0, 64.0, 81.0, 59.0, 56.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 72.0, 73.0, 69.0, 66.0, 66.0, 66.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 80.0, 80.0, 80.0, 79.0, 80.0, 79.0, 83.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 139.0, 142.0, 123.0, 124.0, 125.0, 123.0, 126.0, 144.0, 136.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 163.0, 162.0, 166.0, 166.0, 162.0, 163.0, 165.0, 160.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 69.0, 67.0, 67.0, 66.0, 67.0, 71.0, 64.0, 57.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1501.4999999999998, "alertThreshold": 2.0}]} 02:38:09 INFO - Return code: 0 02:38:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:38:09 ERROR - # TBPL SUCCESS # 02:38:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:38:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:38:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:38:09 INFO - 2016-07-23 02:38:09.297 screenresolution[1956:18954] starting screenresolution argv=screenresolution get 02:38:09 INFO - 2016-07-23 02:38:09.300 screenresolution[1956:18954] Display 0: 1600x1200x32@60 02:38:09 INFO - 2016-07-23 02:38:09.306 screenresolution[1957:18957] starting screenresolution argv=screenresolution list 02:38:09 INFO - Available Modes on Display 0 02:38:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:38:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:38:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:38:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:38:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:38:09 INFO - Intel Iris: 02:38:09 INFO - Chipset Model: Intel Iris 02:38:09 INFO - Type: GPU 02:38:09 INFO - Bus: Built-In 02:38:09 INFO - VRAM (Dynamic, Max): 1536 MB 02:38:09 INFO - Vendor: Intel (0x8086) 02:38:09 INFO - Device ID: 0x0a2e 02:38:09 INFO - Revision ID: 0x0009 02:38:09 INFO - Displays: 02:38:09 INFO - Display: 02:38:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:38:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:38:09 INFO - Display Serial Number: 1600x1200 60 02:38:09 INFO - Main Display: Yes 02:38:09 INFO - Mirror: Off 02:38:09 INFO - Online: Yes 02:38:09 INFO - Rotation: Supported 02:38:09 INFO - Return code: 0 02:38:09 INFO - Running post-action listener: _resource_record_post_action 02:38:09 INFO - Running post-run listener: _resource_record_post_run 02:38:10 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 827392; Write bytes: 494089216; Read time: 10; Write time: 1960 02:38:10 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193217024; Write bytes: 188043776; Read time: 17750; Write time: 368 02:38:10 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 827392; Write bytes: 296251904; Read time: 10; Write time: 1550 02:38:10 INFO - Running post-run listener: _upload_blobber_files 02:38:10 INFO - Blob upload gear active. 02:38:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:38:10 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 02:38:10 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'] 02:38:10 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 02:38:11 INFO - (blobuploader) - INFO - Open directory for files ... 02:38:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:38:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:38:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:12 INFO - (blobuploader) - INFO - Done attempting. 02:38:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:38:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:38:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:13 INFO - (blobuploader) - INFO - Done attempting. 02:38:13 INFO - (blobuploader) - INFO - Iteration through files over. 02:38:13 INFO - Return code: 0 02:38:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:38:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:38:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f2bcb3e123e9b2be53ae2e4d62915adc423673f0430998dc29b00958fe0222dd9747d945d7768ecf7bd174daafb5f33526d76c5e72b7e2560b15e0016aa8a70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3db3332cce2fd0defbf936242eddafbd5733e2dc3fddfc5f3beddffb6bf3ceb6ad522d47d41584cd42224a41902aa557d1a68320c446a09e806fe53371d50e7"} 02:38:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:38:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:38:13 INFO - Contents: 02:38:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f2bcb3e123e9b2be53ae2e4d62915adc423673f0430998dc29b00958fe0222dd9747d945d7768ecf7bd174daafb5f33526d76c5e72b7e2560b15e0016aa8a70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3db3332cce2fd0defbf936242eddafbd5733e2dc3fddfc5f3beddffb6bf3ceb6ad522d47d41584cd42224a41902aa557d1a68320c446a09e806fe53371d50e7"} 02:38:13 INFO - Running post-run listener: copy_logs_to_upload_dir 02:38:13 INFO - Copying logs to upload dir... 02:38:13 INFO - mkdir: /builds/slave/test/build/upload/logs 02:38:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.587811 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-23 02:38:13.283666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-23 02:38:13.286826) ========= 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.aLDTUijPNh/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.xhKJbPnCSW/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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/5f2bcb3e123e9b2be53ae2e4d62915adc423673f0430998dc29b00958fe0222dd9747d945d7768ecf7bd174daafb5f33526d76c5e72b7e2560b15e0016aa8a70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3db3332cce2fd0defbf936242eddafbd5733e2dc3fddfc5f3beddffb6bf3ceb6ad522d47d41584cd42224a41902aa557d1a68320c446a09e806fe53371d50e7"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011314 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469251858/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f2bcb3e123e9b2be53ae2e4d62915adc423673f0430998dc29b00958fe0222dd9747d945d7768ecf7bd174daafb5f33526d76c5e72b7e2560b15e0016aa8a70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3db3332cce2fd0defbf936242eddafbd5733e2dc3fddfc5f3beddffb6bf3ceb6ad522d47d41584cd42224a41902aa557d1a68320c446a09e806fe53371d50e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-23 02:38:13.319578) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 02:38:13.319905) ========= 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.aLDTUijPNh/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.xhKJbPnCSW/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005412 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-23 02:38:13.370226) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-23 02:38:13.370962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-23 02:38:13.371741) ========= ========= Total master_lag: 0.29 =========