builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0233 starttime: 1469206132.99 results: success (0) buildid: 20160722032758 builduid: 6fa0c13327a748b9b0bb88e0184ecac4 revision: 68ca20cf8042a14e44e826e6e7985677c138bfd6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:52.993979) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:52.994467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:52.994739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.107042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.107284) ========= 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.tEUv21xtlq/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.5NGsqE2OYa/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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-22 09:48:53-- 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% 49.3M=0s 2016-07-22 09:48:53 (49.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.593963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.724044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.724328) ========= 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.tEUv21xtlq/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.5NGsqE2OYa/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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.025406 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:53.773912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 09:48:53.774211) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 68ca20cf8042a14e44e826e6e7985677c138bfd6 --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 68ca20cf8042a14e44e826e6e7985677c138bfd6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tEUv21xtlq/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.5NGsqE2OYa/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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-22 09:48:53,857 truncating revision to first 12 chars 2016-07-22 09:48:53,857 Setting DEBUG logging. 2016-07-22 09:48:53,857 attempt 1/10 2016-07-22 09:48:53,857 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/68ca20cf8042?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 09:48:55,294 unpacking tar archive at: mozilla-beta-68ca20cf8042/testing/mozharness/ program finished with exit code 0 elapsedTime=1.716136 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 09:48:55.513680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:55.513996) ========= script_repo_revision: 68ca20cf8042a14e44e826e6e7985677c138bfd6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:55.514409) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:55.514673) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 09:48:55.534572) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-22 09:48:55.534924) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tEUv21xtlq/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.5NGsqE2OYa/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 09:48:55 INFO - MultiFileLogger online at 20160722 09:48:55 in /builds/slave/test 09:48:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:48:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:55 INFO - {'append_to_log': False, 09:48:55 INFO - 'base_work_dir': '/builds/slave/test', 09:48:55 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:48:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:55 INFO - 'branch': 'Mozilla-Beta', 09:48:55 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:55 INFO - 'config_files': ('talos/mac_config.py',), 09:48:55 INFO - 'default_actions': ('clobber', 09:48:55 INFO - 'read-buildbot-config', 09:48:55 INFO - 'download-and-extract', 09:48:55 INFO - 'populate-webroot', 09:48:55 INFO - 'create-virtualenv', 09:48:55 INFO - 'install', 09:48:55 INFO - 'run-tests'), 09:48:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:55 INFO - 'download_minidump_stackwalk': True, 09:48:55 INFO - 'download_symbols': 'ondemand', 09:48:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:55 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:55 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:55 INFO - 'installer_path': 'installer.exe', 09:48:55 INFO - 'log_level': 'info', 09:48:55 INFO - 'log_name': 'talos', 09:48:55 INFO - 'log_to_console': True, 09:48:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:48:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:48:55 INFO - 'opt_config_files': (), 09:48:55 INFO - 'pip_index': False, 09:48:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:55 INFO - 'cmd': ('bash', 09:48:55 INFO - '-c', 09:48:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:55 INFO - 'enabled': True, 09:48:55 INFO - 'halt_on_failure': False, 09:48:55 INFO - 'name': 'check_screen_resolution'},), 09:48:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:55 INFO - 'cmd': ('bash', 09:48:55 INFO - '-c', 09:48:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:55 INFO - 'enabled': True, 09:48:55 INFO - 'halt_on_failure': False, 09:48:55 INFO - 'name': 'check_screen_resolution'},), 09:48:55 INFO - 'run_cmd_checks_enabled': True, 09:48:55 INFO - 'sps_profile': False, 09:48:55 INFO - 'sps_profile_interval': 0, 09:48:55 INFO - 'suite': 'dromaeojs-e10s', 09:48:55 INFO - 'system_bits': '32', 09:48:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:55 INFO - 'title': 't-yosemite-r7-0233', 09:48:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:55 INFO - 'use_talos_json': True, 09:48:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:55 INFO - 'work_dir': 'build'} 09:48:55 INFO - ##### 09:48:55 INFO - ##### Running clobber step. 09:48:55 INFO - ##### 09:48:55 INFO - Running pre-action listener: _resource_record_pre_action 09:48:55 INFO - Running main action method: clobber 09:48:55 INFO - rmtree: /builds/slave/test/build 09:48:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:57 INFO - Running post-action listener: _resource_record_post_action 09:48:57 INFO - ##### 09:48:57 INFO - ##### Running read-buildbot-config step. 09:48:57 INFO - ##### 09:48:57 INFO - Running pre-action listener: _resource_record_pre_action 09:48:57 INFO - Running main action method: read_buildbot_config 09:48:57 INFO - Using buildbot properties: 09:48:57 INFO - { 09:48:57 INFO - "project": "", 09:48:57 INFO - "product": "firefox", 09:48:57 INFO - "script_repo_revision": "production", 09:48:57 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 09:48:57 INFO - "repository": "", 09:48:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 09:48:57 INFO - "buildid": "20160722032758", 09:48:57 INFO - "pgo_build": "False", 09:48:57 INFO - "basedir": "/builds/slave/test", 09:48:57 INFO - "buildnumber": 51, 09:48:57 INFO - "slavename": "t-yosemite-r7-0233", 09:48:57 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:48:57 INFO - "platform": "yosemite_r7", 09:48:57 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:48:57 INFO - "branch": "mozilla-beta", 09:48:57 INFO - "repo_path": "releases/mozilla-beta", 09:48:57 INFO - "revision": "68ca20cf8042a14e44e826e6e7985677c138bfd6", 09:48:57 INFO - "stage_platform": "macosx64", 09:48:57 INFO - "builduid": "6fa0c13327a748b9b0bb88e0184ecac4", 09:48:57 INFO - "slavebuilddir": "test" 09:48:57 INFO - } 09:48:57 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg. 09:48:57 INFO - Running post-action listener: _resource_record_post_action 09:48:57 INFO - ##### 09:48:57 INFO - ##### Running download-and-extract step. 09:48:57 INFO - ##### 09:48:57 INFO - Running pre-action listener: _resource_record_pre_action 09:48:57 INFO - Running main action method: download_and_extract 09:48:57 INFO - mkdir: /builds/slave/test/build/tests 09:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.test_packages.json 09:48:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/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 09:48:58 INFO - Downloaded 1165 bytes. 09:48:58 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:48:58 INFO - Using the following test package requirements: 09:48:58 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:48:58 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:58 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 09:48:58 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:58 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 09:48:58 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:48:58 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:58 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 09:48:58 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:48:58 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:58 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 09:48:58 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:58 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 09:48:58 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:58 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 09:48:58 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:48:58 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 09:48:58 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 09:48:58 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')]} 09:48:58 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.common.tests.zip 09:48:58 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 09:48:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/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 09:49:00 INFO - Downloaded 18314888 bytes. 09:49:00 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'] 09:49:00 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 09:49:03 INFO - Return code: 0 09:49:03 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 09:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.common.tests.zip 09:49:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 09:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/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 09:49:03 INFO - Downloaded 18314888 bytes. 09:49:03 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'] 09:49:03 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 09:49:06 INFO - Return code: 0 09:49:06 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')]} 09:49:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.talos.tests.zip 09:49:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 09:49:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/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 09:49:09 INFO - Downloaded 10840145 bytes. 09:49:09 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'] 09:49:09 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 09:49:09 INFO - Return code: 0 09:49: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')]} 09:49:09 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg 09:49:09 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 09:49:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 09:49:22 INFO - Downloaded 86192613 bytes. 09:49:22 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg 09:49:22 INFO - mkdir: /builds/slave/test/properties 09:49:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:49:22 INFO - Writing to file /builds/slave/test/properties/build_url 09:49:22 INFO - Contents: 09:49:22 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg 09:49:22 INFO - Running post-action listener: _resource_record_post_action 09:49:22 INFO - Running post-action listener: set_extra_try_arguments 09:49:22 INFO - ##### 09:49:22 INFO - ##### Running populate-webroot step. 09:49:22 INFO - ##### 09:49:22 INFO - Running pre-action listener: _resource_record_pre_action 09:49:22 INFO - Running main action method: populate_webroot 09:49:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:49:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:49:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:49:22 INFO - '--tppagecycles', 09:49:22 INFO - '7'], 09:49:22 INFO - 'tests': ['tsvgm']}}, 09:49:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:49:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:49:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:49:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:49:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:49:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:49:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:22 INFO - 'talos_options': ['--disable-e10s'], 09:49:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:22 INFO - 'talos_options': ['--disable-e10s'], 09:49:22 INFO - 'tests': ['damp', 'tps']}, 09:49:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:22 INFO - 'tests': ['damp', 'tps']}, 09:49:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:49:22 INFO - 'tests': ['dromaeo_dom']}, 09:49:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:49:22 INFO - 'tests': ['a11yr', 09:49:22 INFO - 'ts_paint', 09:49:22 INFO - 'tpaint', 09:49:22 INFO - 'sessionrestore', 09:49:22 INFO - 'sessionrestore_no_auto_restore', 09:49:22 INFO - 'tabpaint']}, 09:49:22 INFO - 'other-e10s': {'tests': ['a11yr', 09:49:22 INFO - 'ts_paint', 09:49:22 INFO - 'tpaint', 09:49:22 INFO - 'sessionrestore', 09:49:22 INFO - 'sessionrestore_no_auto_restore', 09:49:22 INFO - 'tabpaint']}, 09:49:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:49:22 INFO - 'ts_paint', 09:49:22 INFO - 'tpaint', 09:49:22 INFO - 'sessionrestore', 09:49:22 INFO - 'sessionrestore_no_auto_restore', 09:49:22 INFO - 'tabpaint']}, 09:49:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:49:22 INFO - 'ts_paint', 09:49:22 INFO - 'tpaint', 09:49:22 INFO - 'sessionrestore', 09:49:22 INFO - 'sessionrestore_no_auto_restore', 09:49:22 INFO - 'tabpaint']}, 09:49:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:49:22 INFO - 'tests': ['a11yr', 09:49:22 INFO - 'ts_paint', 09:49:22 INFO - 'tpaint', 09:49:22 INFO - 'sessionrestore', 09:49:22 INFO - 'sessionrestore_no_auto_restore', 09:49:22 INFO - 'tabpaint']}, 09:49:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:49:22 INFO - 'tests': ['a11yr', 09:49:22 INFO - 'ts_paint', 09:49:22 INFO - 'tpaint', 09:49:22 INFO - 'sessionrestore', 09:49:22 INFO - 'sessionrestore_no_auto_restore', 09:49:22 INFO - 'tabpaint']}, 09:49:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:49:22 INFO - 'tests': ['tsvgx', 09:49:22 INFO - 'tsvgr_opacity', 09:49:22 INFO - 'tart', 09:49:22 INFO - 'tscrollx', 09:49:22 INFO - 'cart']}, 09:49:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:49:22 INFO - 'tsvgr_opacity', 09:49:22 INFO - 'tart', 09:49:22 INFO - 'tscrollx', 09:49:22 INFO - 'cart']}, 09:49:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:22 INFO - 'talos_options': ['--disable-e10s'], 09:49:22 INFO - 'tests': ['tp5o']}, 09:49:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:22 INFO - 'tests': ['tp5o']}, 09:49:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:22 INFO - 'talos_options': ['--disable-e10s', 09:49:22 INFO - '--xperf_path', 09:49:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:22 INFO - 'tests': ['tp5n']}, 09:49:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:22 INFO - 'talos_options': ['--xperf_path', 09:49:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:22 INFO - 'tests': ['tp5n']}}, 09:49:22 INFO - 'talos.zip': {'path': '', 09:49:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:22 INFO - Running post-action listener: _resource_record_post_action 09:49:22 INFO - ##### 09:49:22 INFO - ##### Running create-virtualenv step. 09:49:22 INFO - ##### 09:49:22 INFO - Running pre-action listener: _resource_record_pre_action 09:49:22 INFO - Running main action method: create_virtualenv 09:49:22 INFO - Creating virtualenv /builds/slave/test/build/venv 09:49:22 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 09:49:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:49:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:22 INFO - Using real prefix '/tools/python27' 09:49:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:49:23 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:26 INFO - Installing pip.................done. 09:49:26 INFO - Return code: 0 09:49:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:26 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 0x11034ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5dac95d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101eae00>, '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 0x110053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e5b20>, '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.tEUv21xtlq/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.5NGsqE2OYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 09:49:26 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 09:49:26 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 09:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEUv21xtlq/Render', 09:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:26 INFO - 'HOME': '/Users/cltbld', 09:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:26 INFO - 'LOGNAME': 'cltbld', 09:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:26 INFO - 'MOZ_NO_REMOTE': '1', 09:49:26 INFO - 'NO_EM_RESTART': '1', 09:49:26 INFO - 'PAGER': '/bin/cat', 09:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:26 INFO - 'PWD': '/builds/slave/test', 09:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:26 INFO - 'SHELL': '/bin/bash', 09:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NGsqE2OYa/Listeners', 09:49:26 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 09:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:26 INFO - 'USER': 'cltbld', 09:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:26 INFO - 'XPC_FLAGS': '0x0', 09:49:26 INFO - 'XPC_SERVICE_NAME': '0', 09:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:26 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 09:49:26 INFO - Cleaning up... 09:49:26 INFO - Return code: 0 09:49:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:26 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 0x11034ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5dac95d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101eae00>, '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 0x110053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e5b20>, '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.tEUv21xtlq/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.5NGsqE2OYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 09:49:26 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 09:49:26 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 09:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEUv21xtlq/Render', 09:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:26 INFO - 'HOME': '/Users/cltbld', 09:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:26 INFO - 'LOGNAME': 'cltbld', 09:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:26 INFO - 'MOZ_NO_REMOTE': '1', 09:49:26 INFO - 'NO_EM_RESTART': '1', 09:49:26 INFO - 'PAGER': '/bin/cat', 09:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:26 INFO - 'PWD': '/builds/slave/test', 09:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:26 INFO - 'SHELL': '/bin/bash', 09:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NGsqE2OYa/Listeners', 09:49:26 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 09:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:26 INFO - 'USER': 'cltbld', 09:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:26 INFO - 'XPC_FLAGS': '0x0', 09:49:26 INFO - 'XPC_SERVICE_NAME': '0', 09:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:26 INFO - Downloading/unpacking psutil>=0.7.1 09:49:26 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 09:49:26 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 09:49:26 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 09:49:26 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 09:49:26 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 09:49:26 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 09:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:30 INFO - Installing collected packages: psutil 09:49:30 INFO - Running setup.py install for psutil 09:49:30 INFO - building 'psutil._psutil_osx' extension 09:49:30 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 09:49:31 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 09:49:31 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 09:49:31 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 09:49:31 INFO - building 'psutil._psutil_posix' extension 09:49:31 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 09:49:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:49:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:49:31 INFO - ^ 09:49:31 INFO - 1 warning generated. 09:49:31 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 09:49:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:31 INFO - Successfully installed psutil 09:49:31 INFO - Cleaning up... 09:49:31 INFO - Return code: 0 09:49:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11034ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5dac95d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101eae00>, '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 0x110053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e5b20>, '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.tEUv21xtlq/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.5NGsqE2OYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 09:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:49:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEUv21xtlq/Render', 09:49:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:31 INFO - 'HOME': '/Users/cltbld', 09:49:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:31 INFO - 'LOGNAME': 'cltbld', 09:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:31 INFO - 'MOZ_NO_REMOTE': '1', 09:49:31 INFO - 'NO_EM_RESTART': '1', 09:49:31 INFO - 'PAGER': '/bin/cat', 09:49:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:31 INFO - 'PWD': '/builds/slave/test', 09:49:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:31 INFO - 'SHELL': '/bin/bash', 09:49:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NGsqE2OYa/Listeners', 09:49:31 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 09:49:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:31 INFO - 'USER': 'cltbld', 09:49:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:31 INFO - 'XPC_FLAGS': '0x0', 09:49:31 INFO - 'XPC_SERVICE_NAME': '0', 09:49:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:49:31 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 09:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:49:34 INFO - Installing collected packages: mozsystemmonitor 09:49:34 INFO - Running setup.py install for mozsystemmonitor 09:49:34 INFO - Successfully installed mozsystemmonitor 09:49:34 INFO - Cleaning up... 09:49:34 INFO - Return code: 0 09:49:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:34 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 0x11034ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5dac95d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101eae00>, '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 0x110053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e5b20>, '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.tEUv21xtlq/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.5NGsqE2OYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 09:49:34 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 09:49:34 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 09:49:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEUv21xtlq/Render', 09:49:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:34 INFO - 'HOME': '/Users/cltbld', 09:49:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:34 INFO - 'LOGNAME': 'cltbld', 09:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:34 INFO - 'MOZ_NO_REMOTE': '1', 09:49:34 INFO - 'NO_EM_RESTART': '1', 09:49:34 INFO - 'PAGER': '/bin/cat', 09:49:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:34 INFO - 'PWD': '/builds/slave/test', 09:49:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:34 INFO - 'SHELL': '/bin/bash', 09:49:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NGsqE2OYa/Listeners', 09:49:34 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 09:49:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:34 INFO - 'USER': 'cltbld', 09:49:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:34 INFO - 'XPC_FLAGS': '0x0', 09:49:34 INFO - 'XPC_SERVICE_NAME': '0', 09:49:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:34 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:34 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 09:49:34 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 09:49:34 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 09:49:34 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 09:49:34 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 09:49:34 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 09:49:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:49:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:38 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 09:49:38 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 09:49:38 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 09:49:38 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 09:49:38 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 09:49:38 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 09:49:38 INFO - Downloading docopt-0.6.1.tar.gz 09:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:38 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:38 INFO - Running setup.py install for blobuploader 09:49:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:38 INFO - Running setup.py install for requests 09:49:39 INFO - Running setup.py install for docopt 09:49:39 INFO - Successfully installed blobuploader requests docopt 09:49:39 INFO - Cleaning up... 09:49:39 INFO - Return code: 0 09:49:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:39 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 0x11034ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5dac95d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101eae00>, '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 0x110053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e5b20>, '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.tEUv21xtlq/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.5NGsqE2OYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 09:49:39 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 09:49:39 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 09:49:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEUv21xtlq/Render', 09:49:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:39 INFO - 'HOME': '/Users/cltbld', 09:49:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:39 INFO - 'LOGNAME': 'cltbld', 09:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:39 INFO - 'MOZ_NO_REMOTE': '1', 09:49:39 INFO - 'NO_EM_RESTART': '1', 09:49:39 INFO - 'PAGER': '/bin/cat', 09:49:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:39 INFO - 'PWD': '/builds/slave/test', 09:49:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:39 INFO - 'SHELL': '/bin/bash', 09:49:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NGsqE2OYa/Listeners', 09:49:39 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 09:49:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:39 INFO - 'USER': 'cltbld', 09:49:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:39 INFO - 'XPC_FLAGS': '0x0', 09:49:39 INFO - 'XPC_SERVICE_NAME': '0', 09:49:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:39 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-VDtQqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:39 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-yeLGKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:40 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-f9m_O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:40 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-Pq6qnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:40 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-r3nkkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:40 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-uvywXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:40 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-jMl8fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:40 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-jRX2iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:40 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-yWTMSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:40 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-XOBwsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:40 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-SFR8eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:40 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-RfU8FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:41 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-56otZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:41 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-RNORrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:41 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-s9mTs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:41 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-TFDk6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:41 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-fuU_uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:41 INFO - Running setup.py install for manifestparser 09:49:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:49:41 INFO - Running setup.py install for mozcrash 09:49:41 INFO - Running setup.py install for mozdebug 09:49:41 INFO - Running setup.py install for mozdevice 09:49:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:49:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:49:42 INFO - Running setup.py install for mozfile 09:49:42 INFO - Running setup.py install for mozhttpd 09:49:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:49:42 INFO - Running setup.py install for mozinfo 09:49:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:49:42 INFO - Running setup.py install for mozInstall 09:49:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:49:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:49:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:49:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:49:42 INFO - Running setup.py install for mozleak 09:49:42 INFO - Running setup.py install for mozlog 09:49:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:49:43 INFO - Running setup.py install for moznetwork 09:49:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:49:43 INFO - Running setup.py install for mozprocess 09:49:43 INFO - Running setup.py install for mozprofile 09:49:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:49:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:49:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:49:43 INFO - Running setup.py install for mozrunner 09:49:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:49:43 INFO - Running setup.py install for mozscreenshot 09:49:43 INFO - Running setup.py install for moztest 09:49:43 INFO - Running setup.py install for mozversion 09:49:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:49:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:44 INFO - Cleaning up... 09:49:44 INFO - Return code: 0 09:49:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:44 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 0x11034ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5dac95d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101eae00>, '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 0x110053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e5b20>, '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.tEUv21xtlq/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.5NGsqE2OYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 09:49:44 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 09:49:44 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 09:49:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEUv21xtlq/Render', 09:49:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:44 INFO - 'HOME': '/Users/cltbld', 09:49:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:44 INFO - 'LOGNAME': 'cltbld', 09:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:44 INFO - 'MOZ_NO_REMOTE': '1', 09:49:44 INFO - 'NO_EM_RESTART': '1', 09:49:44 INFO - 'PAGER': '/bin/cat', 09:49:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:44 INFO - 'PWD': '/builds/slave/test', 09:49:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:44 INFO - 'SHELL': '/bin/bash', 09:49:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NGsqE2OYa/Listeners', 09:49:44 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 09:49:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:44 INFO - 'USER': 'cltbld', 09:49:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:44 INFO - 'XPC_FLAGS': '0x0', 09:49:44 INFO - 'XPC_SERVICE_NAME': '0', 09:49:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:44 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-W5NPVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:44 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)) 09:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:44 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-4db0nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:44 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)) 09:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:44 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-mdN0Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:44 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)) 09:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:44 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-W7hZ1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:44 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)) 09:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:44 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-7vFeIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:44 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)) 09:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:44 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-dLpfQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:44 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)) 09:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:44 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-6neWOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:45 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)) 09:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:45 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-34WU6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:45 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)) 09:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:45 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-nXK7hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:45 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)) 09:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:45 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-n8Numo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:45 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)) 09:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:45 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-97xr0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:45 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)) 09:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:45 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-PvWU3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:45 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)) 09:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:45 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-HK5cnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:45 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)) 09:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:45 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-aooht9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:45 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)) 09:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:45 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-px60HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:45 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)) 09:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:45 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-_3aLu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:46 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)) 09:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:46 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-wycvWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:46 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)) 09:49:46 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)) 09:49:46 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)) 09:49:46 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)) 09:49:46 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)) 09:49:46 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)) 09:49:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:48 INFO - Downloading blessings-1.6.tar.gz 09:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:48 INFO - Installing collected packages: blessings 09:49:48 INFO - Running setup.py install for blessings 09:49:48 INFO - Successfully installed blessings 09:49:48 INFO - Cleaning up... 09:49:49 INFO - Return code: 0 09:49:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:49:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:49 INFO - Reading from file tmpfile_stdout 09:49:49 INFO - Current package versions: 09:49:49 INFO - blessings == 1.6 09:49:49 INFO - blobuploader == 1.2.4 09:49:49 INFO - docopt == 0.6.1 09:49:49 INFO - manifestparser == 1.1 09:49:49 INFO - mozInstall == 1.12 09:49:49 INFO - mozcrash == 0.17 09:49:49 INFO - mozdebug == 0.1 09:49:49 INFO - mozdevice == 0.48 09:49:49 INFO - mozfile == 1.2 09:49:49 INFO - mozhttpd == 0.7 09:49:49 INFO - mozinfo == 0.9 09:49:49 INFO - mozleak == 0.1 09:49:49 INFO - mozlog == 3.1 09:49:49 INFO - moznetwork == 0.27 09:49:49 INFO - mozprocess == 0.22 09:49:49 INFO - mozprofile == 0.28 09:49:49 INFO - mozrunner == 6.11 09:49:49 INFO - mozscreenshot == 0.1 09:49:49 INFO - mozsystemmonitor == 0.0 09:49:49 INFO - moztest == 0.7 09:49:49 INFO - mozversion == 1.4 09:49:49 INFO - psutil == 3.1.1 09:49:49 INFO - requests == 1.2.3 09:49:49 INFO - wsgiref == 0.1.2 09:49:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:49 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')]} 09:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:49 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')]} 09:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:49 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 0x11034ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5dac95d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101eae00>, '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 0x110053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e5b20>, '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.tEUv21xtlq/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.5NGsqE2OYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 09:49:49 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 09:49:49 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 09:49:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEUv21xtlq/Render', 09:49:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:49 INFO - 'HOME': '/Users/cltbld', 09:49:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:49 INFO - 'LOGNAME': 'cltbld', 09:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:49 INFO - 'MOZ_NO_REMOTE': '1', 09:49:49 INFO - 'NO_EM_RESTART': '1', 09:49:49 INFO - 'PAGER': '/bin/cat', 09:49:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:49 INFO - 'PWD': '/builds/slave/test', 09:49:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:49 INFO - 'SHELL': '/bin/bash', 09:49:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NGsqE2OYa/Listeners', 09:49:49 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 09:49:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:49 INFO - 'USER': 'cltbld', 09:49:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:49 INFO - 'XPC_FLAGS': '0x0', 09:49:49 INFO - 'XPC_SERVICE_NAME': '0', 09:49:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:49 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)) 09:49:49 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)) 09:49:49 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)) 09:49:49 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)) 09:49:49 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)) 09:49:49 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)) 09:49:49 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)) 09:49:49 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)) 09:49:49 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)) 09:49:49 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)) 09:49:49 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)) 09:49:49 INFO - Cleaning up... 09:49:49 INFO - Return code: 0 09:49:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:49:49 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')]} 09:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:49 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')]} 09:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:49 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 0x11034ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5dac95d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101eae00>, '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 0x110053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e5b20>, '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.tEUv21xtlq/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.5NGsqE2OYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 09:49:49 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 09:49:49 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 09:49:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEUv21xtlq/Render', 09:49:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:49 INFO - 'HOME': '/Users/cltbld', 09:49:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:49 INFO - 'LOGNAME': 'cltbld', 09:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:49 INFO - 'MOZ_NO_REMOTE': '1', 09:49:49 INFO - 'NO_EM_RESTART': '1', 09:49:49 INFO - 'PAGER': '/bin/cat', 09:49:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:49 INFO - 'PWD': '/builds/slave/test', 09:49:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:49 INFO - 'SHELL': '/bin/bash', 09:49:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NGsqE2OYa/Listeners', 09:49:49 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 09:49:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:49 INFO - 'USER': 'cltbld', 09:49:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:49 INFO - 'XPC_FLAGS': '0x0', 09:49:49 INFO - 'XPC_SERVICE_NAME': '0', 09:49:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:49 INFO - Downloading/unpacking jsonschema 09:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:52 INFO - Downloading/unpacking functools32 (from jsonschema) 09:49:52 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 09:49:52 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 09:49:52 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 09:49:52 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 09:49:52 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 09:49:52 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 09:49:52 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:52 INFO - warning: no files found matching '*.txt' 09:49:52 INFO - no previously-included directories found matching 'build' 09:49:52 INFO - no previously-included directories found matching 'dist' 09:49:52 INFO - no previously-included directories found matching '.git*' 09:49:52 INFO - Installing collected packages: jsonschema, functools32 09:49:52 INFO - Running setup.py install for functools32 09:49:52 INFO - warning: no files found matching '*.txt' 09:49:52 INFO - no previously-included directories found matching 'build' 09:49:52 INFO - no previously-included directories found matching 'dist' 09:49:52 INFO - no previously-included directories found matching '.git*' 09:49:52 INFO - Successfully installed jsonschema functools32 09:49:52 INFO - Cleaning up... 09:49:53 INFO - Return code: 0 09:49:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:49:53 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')]} 09:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:53 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')]} 09:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:53 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 0x11034ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11035b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5dac95d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101eae00>, '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 0x110053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e5b20>, '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.tEUv21xtlq/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.5NGsqE2OYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 09:49:53 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 09:49:53 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 09:49:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEUv21xtlq/Render', 09:49:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:53 INFO - 'HOME': '/Users/cltbld', 09:49:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:53 INFO - 'LOGNAME': 'cltbld', 09:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:53 INFO - 'MOZ_NO_REMOTE': '1', 09:49:53 INFO - 'NO_EM_RESTART': '1', 09:49:53 INFO - 'PAGER': '/bin/cat', 09:49:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:53 INFO - 'PWD': '/builds/slave/test', 09:49:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:53 INFO - 'SHELL': '/bin/bash', 09:49:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NGsqE2OYa/Listeners', 09:49:53 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 09:49:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:53 INFO - 'USER': 'cltbld', 09:49:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:53 INFO - 'XPC_FLAGS': '0x0', 09:49:53 INFO - 'XPC_SERVICE_NAME': '0', 09:49:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:53 INFO - Downloading/unpacking flake8 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:49:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:49:55 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 09:49:55 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 09:49:55 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 09:49:55 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 09:49:55 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 09:49:55 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 09:49:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:49:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:57 INFO - no previously-included directories found matching 'docs/_build' 09:49:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:49:57 INFO - Running setup.py install for pep8 09:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:57 INFO - no previously-included directories found matching 'docs/_build' 09:49:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:49:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:49:57 INFO - Cleaning up... 09:49:57 INFO - Return code: 0 09:49:57 INFO - Running post-action listener: _resource_record_post_action 09:49:57 INFO - Running post-action listener: _start_resource_monitoring 09:49:57 INFO - Starting resource monitoring. 09:49:57 INFO - ##### 09:49:57 INFO - ##### Running install step. 09:49:57 INFO - ##### 09:49:57 INFO - Running pre-action listener: _resource_record_pre_action 09:49:57 INFO - Running main action method: install 09:49:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:57 INFO - Reading from file tmpfile_stdout 09:49:57 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:57 INFO - Reading from file tmpfile_stdout 09:49:57 INFO - Output received: 09:49:57 INFO - Usage: mozinstall [options] installer 09:49:57 INFO - Options: 09:49:57 INFO - -h, --help show this help message and exit 09:49:57 INFO - -d DEST, --destination=DEST 09:49:57 INFO - Directory to install application into. [default: 09:49:57 INFO - "/builds/slave/test"] 09:49:57 INFO - --app=APP Application being installed. [default: firefox] 09:49:57 INFO - mkdir: /builds/slave/test/build/application 09:49:57 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'] 09:49:57 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 09:50:19 INFO - Reading from file tmpfile_stdout 09:50:19 INFO - Output received: 09:50:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:50:19 INFO - Running post-action listener: _resource_record_post_action 09:50:19 INFO - ##### 09:50:19 INFO - ##### Running run-tests step. 09:50:19 INFO - ##### 09:50:19 INFO - Running pre-action listener: _resource_record_pre_action 09:50:19 INFO - Running main action method: run_tests 09:50:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:50:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:50:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:50:19 INFO - 2016-07-22 09:50:19.638 screenresolution[1647:8342] starting screenresolution argv=screenresolution get 09:50:19 INFO - 2016-07-22 09:50:19.641 screenresolution[1647:8342] Display 0: 1600x1200x32@60 09:50:19 INFO - 2016-07-22 09:50:19.647 screenresolution[1648:8344] starting screenresolution argv=screenresolution list 09:50:19 INFO - Available Modes on Display 0 09:50:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:50:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:50:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:50:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:50:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:50:19 INFO - Intel Iris: 09:50:19 INFO - Chipset Model: Intel Iris 09:50:19 INFO - Type: GPU 09:50:19 INFO - Bus: Built-In 09:50:19 INFO - VRAM (Dynamic, Max): 1536 MB 09:50:19 INFO - Vendor: Intel (0x8086) 09:50:19 INFO - Device ID: 0x0a2e 09:50:19 INFO - Revision ID: 0x0009 09:50:19 INFO - Displays: 09:50:19 INFO - Display: 09:50:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:50:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:50:19 INFO - Display Serial Number: 1600x1200 60 09:50:19 INFO - Main Display: Yes 09:50:19 INFO - Mirror: Off 09:50:19 INFO - Online: Yes 09:50:19 INFO - Rotation: Supported 09:50:19 INFO - Return code: 0 09:50:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:50:19 INFO - Python 2.7.3 09:50:19 INFO - Return code: 0 09:50:19 INFO - grabbing minidump binary from tooltool 09:50:19 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')]} 09:50:19 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 0x1101eae00>, '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 0x110053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101e5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:50:19 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 09:50:19 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 09:50:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:50:19 INFO - Return code: 0 09:50:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:50:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:50:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:50:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:50:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:50:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:50:21 INFO - Return code: 0 09:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0233', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0233 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEUv21xtlq/Render', 09:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:21 INFO - 'HOME': '/Users/cltbld', 09:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:21 INFO - 'LOGNAME': 'cltbld', 09:50:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:50:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:21 INFO - 'MOZ_NO_REMOTE': '1', 09:50:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:50:21 INFO - 'NO_EM_RESTART': '1', 09:50:21 INFO - 'PAGER': '/bin/cat', 09:50:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:21 INFO - 'PWD': '/builds/slave/test', 09:50:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:21 INFO - 'SHELL': '/bin/bash', 09:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5NGsqE2OYa/Listeners', 09:50:21 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 09:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:21 INFO - 'USER': 'cltbld', 09:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:21 INFO - 'XPC_FLAGS': '0x0', 09:50:21 INFO - 'XPC_SERVICE_NAME': '0', 09:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0233', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:50:21 INFO - mozversion application_buildid: 20160722032758 09:50:21 INFO - mozversion application_changeset: 68ca20cf8042a14e44e826e6e7985677c138bfd6 09:50:21 INFO - mozversion application_display_name: Firefox 09:50:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:21 INFO - mozversion application_name: Firefox 09:50:21 INFO - mozversion application_remotingname: firefox 09:50:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:50:21 INFO - mozversion application_vendor: Mozilla 09:50:21 INFO - mozversion application_version: 48.0 09:50:21 INFO - mozversion platform_buildid: 20160722032758 09:50:21 INFO - mozversion platform_changeset: 68ca20cf8042a14e44e826e6e7985677c138bfd6 09:50:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:50:21 INFO - mozversion platform_version: 48.0 09:50:21 INFO - using testdate: 1469206221 09:50:21 INFO - actual date: 1469206221 09:50:21 INFO - starting webserver on 'localhost:49264' 09:50:21 INFO - SUITE-START | Running 2 tests 09:50:21 INFO - TEST-START | dromaeo_css 09:50:21 INFO - operating with platform_type : mac_ 09:50:21 INFO - Initialising browser for dromaeo_css test... 09:50:21 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpAm4rdh/profile http://localhost:49264/getInfo.html) 09:50:24 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 09:50:24 INFO - PROCESS | 1666 | colorDepth:24 09:50:24 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 09:50:24 INFO - PROCESS | 1666 | __metrics 09:50:24 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 09:50:24 INFO - TEST-INFO | 1666: exit 0 09:50:24 INFO - Browser initialized. 09:50:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:24 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpAm4rdh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:36 INFO - PROCESS | 1671 | RSS: Main: 171048960 09:50:36 INFO - PROCESS | 1671 | 09:51:26 INFO - PROCESS | 1671 | 1469206286482 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] 09:53:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 09:53:37 INFO - PROCESS | 1671 | RSS: Main: 181702656 09:53:37 INFO - PROCESS | 1671 | 09:56:40 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 09:56:40 INFO - PROCESS | 1671 | RSS: Main: 192479232 09:56:40 INFO - PROCESS | 1671 | 09:59:42 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 09:59:43 INFO - PROCESS | 1671 | RSS: Main: 194686976 09:59:43 INFO - PROCESS | 1671 | 10:02:44 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 10:02:45 INFO - PROCESS | 1671 | RSS: Main: 198377472 10:02:45 INFO - PROCESS | 1671 | 10:05:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 10:05:48 INFO - PROCESS | 1671 | RSS: Main: 197513216 10:05:48 INFO - PROCESS | 1671 | 10:08:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 10:08:51 INFO - PROCESS | 1671 | RSS: Main: 203378688 10:08:51 INFO - PROCESS | 1671 | 10:08:51 INFO - PROCESS | 1671 | __start_tp_report 10:08:51 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 10:08:51 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 10:08:51 INFO - PROCESS | 1671 | |i|pagename|runs| 10:08:51 INFO - PROCESS | 1671 | |0;dojo.html;2994.6556146043204;3716.9628303716954;3719.4606782016626;3749.362608356579;3753.5871054184036;6012.458878700916;6047.425494578014;6096.969515152418;6097.115918191865;6110.6028108172995;6058.394160583939;6075.392460753922;6084.269887613482;6091.208142941411;6118.082287656854;5403.459654034595;5424.945750542503;5431.592630552725;5512.834614961537;5541.362743284513;5402.594805389592;5431.456854314576;5487.451254874501;5530.557555395579;5531.751071201806;5503.091989821674;5516.668999860021;5519.613627046108;5526.171074338841;5540.113581826909;5489.1217405215375;5493.395726470085;5503.3395992480955;5534.723263836792;5534.972325138368;5339.41266460689;5343.759530821122;5417.59368047398;5449.482299181572;5518.91721624176;5800.88398232033;5889.9705501472645;5940.61386009908;5944.316403613597;5973.551983601204;6223.502119830448;6320.525960552977;6334.3032266450655;6381.202349706286;6418.646974416405;6371.362863713638;6397.584157029778;6451.129097571815;6469.93530064698;6474.74101035958;6168.722407491674;6169.29053158888;6174.444300012976;6174.44430001302;6199.3490683478485;6385.5210859185745;6476.481881449473;6635.8009259722285;6638.867222655616;6642.767503137367;6236.469900058455;6299.874002520016;6323.5573509854785;6326.019466982625;6330.3669633036325;6375.330590288046;6426.196725409324;6427.22873255203;6451.096846441502;6454.419102280817;6224.128621992924;6239.625622462667;6284.591501552384;6301.464375528039;6307.621542707452;6299.149614802035;6312.842178945563;6323.873522529524;6332.461740751995;6553.541252112306;5113.207452844815;5149.819756308511;5156.865489592284;5171.81898633546;5184.11869982104;4516.796744146522;4605.0559635274685;4641.280601506772;4646;4703.7883295251795;6049.5462840287155;6092.847678808065;6102.967607940184;6141.056449558148;6175.84560385994;6421.4541763949655;6469.870602587922;6487.156669632917;6506.512011599149;6514.185726784152;5955.880882382328;6129.233845769279;6180.381961803783;6192.040233763774;6208.534359923024;5690.772369105272;5691.345495268097;5693.971530142323;5700.771969121189;5707.4577915098;6693.598384096969;6702.0282059101155;6719.092922455504;6734.730610775514;6738.73045078211;6319.24169099711;6349.904751428825;6425.742970281323;6448.5163612730175;6482.805515834532;6691.230508491391;6705.698243578953;6712.328767123248;6713.6643167842385;6749.93250067493;6348.746050158126;6364.745410183541;6365.61806291624;6366.4588509977175;6369.649669268235;6191.81424557264;6364.172657554488;6418.005209192583;6426.260979987362;6494.870102598016;6144.2319710036245;6237.844053898689;6270.7805226816845;6275.560710750204;6283.120363149254;6160.630362178284;6241.251049874044;6242.094896240111;6258.530610204162;6278.780242691484;5477.561795056466;6093.6039157454625;6141.723622437091;6212.06818977157;6213.937860621336;5986.970065149646;6222;6235.75056997715;6244.438000579969;6254.249490061222;6155.876882462415;6157.907631385622;6189;6194.566380353332;6269.247690277196 10:08:51 INFO - PROCESS | 1671 | |1;ext.html;542.3871025740915;550.7053726256454;557.5261028126092;575.7380391921677;602.0427520242813;34381.82809085957;40746.59253407465;40844.183116337656;40852;40979;41233.58766412335;41651.791741041256;41732;41775.58224417755;41822.58177418233;8710.390272680916;9344.859827102617;9873.506324683773;9875;9882;9762.853557196613;9982.151517121054;10004.74988125299;10004.799904001915;10018.298719089667;9962.701118966443;9967.102960733533;9985.850212246822;10026.849597256047;10052.949735251314;8987.236084932756;9682.56428460721;9967.90032099677;9976.05227503386;10030.949845250727;8340.457870238415;9786.314957952945;9956.651517196935;9966.003399660049;10081.798364032751;40446.79776601098;40662;41387.7930610345;41562.792186038874;41797.1640567187;2426.3206302235403;2892.971070289312;3340.6659334066644;3827.32355482288;4091.8363265469347;24777.380565485826;27761.86119069412;28760;28989.56515652267;29413.26466838346;2333.988330058356;2758.600002999554;2822.139247529503;2838.4181242845166;2904.695007024274;369301;373272;375655;377492;378002.99999999726;50417.999999999265;51781.482185177665;59570.80858382808;61903.76192476125;67162.98511044677;67726;74100.62949685217;75192.87210691844;75708;75741.86387204197;15317.540473785804;17866.821331786774;18777.530561736065;18828.811711882707;19015.954122523395;11470.54117835294;14331.641708957151;14492.710145797026;14604.34280457382;14612.26938653063;17060.744088838677;20277;20408.489787755127;20603.175872965214;20715.4821129473;8381.287590554872;8430.620622072021;8481.40630155883;8485.515034868873;8517.850090237862;963.5375019990444;1071.7267096890243;1104.1884215101893;1116.547798141754;1126.3973774030853;30469.695303046687;30779;31210.53184202239;31512.527312090337;31560.842195788875;1143.519721716881;1155.930644161353;1163.9825402618967;1228.5638598297655;1231.6859200903712;15502.922485387726;15849.52451426459;15922.123082594851;15966.840331596768;16308.021518708916;662146;803769;803992;809747;819187;65064.0240396385;65144.348556513825;65811.34188658147;65909;65996.67001664962;1326.3235749767496;1550.759632257002;1551.6586351002761;1553.7436323006802;1616.13536757834;22247.555048899256;31295.687043130187;31703.84148079245;31914.52128218125;32016.839915801203;55605.72197138988;55809;56194;56273.155902662314;56434.153487696894;605519;613325;625068;628675;629071;24517.50964980726;27295.72704272932;27931.581026284217;28809.42381152407;28839.423211536072;47593.52406475891;47895;48061;48252.758736206095;49677;32905.67094329122;38592.80703596464;38795.22409551737;39452.40821387739;39758.80120599378;38451.42322865103;38461.423078653286;38812.6118738809;39335.213295734495;39349.01627459336;38116.809415952746;39113.80443097766;39210;39390.80304598458;39659.80170099131;27944.580831287953;33813.830930845186;34269.65730342665;34282.65717342795;34532.65467345295;25675.35811604725;25858.482830342913;26227.73772262253;26295.60556591691;26302.21093367202 10:08:51 INFO - PROCESS | 1671 | |2;jquery.html;420.0737374090132;420.3002001667222;429.22310617781807;432.902596915694;434.6913691279192;20145.798542014574;20304.984750762476;20997;21968.340949771533;22700.524465909704;15431.151286679227;17277.568060798487;18810.717839232388;20560;21586.460338491546;5185.092608793465;5837.708114594253;6106.786262480814;6156.38436156383;6156.815295541141;5972.761089556434;6112.633242005494;6143.354947730491;6151.138840562325;6874.10636617239;6825.3857152856235;6828.419584335337;6829.146356705412;6829.760958366458;6852.588844669311;6462.675151593912;6710;6710.127683401175;6788.592684438925;6811.795646130624;5935.347111817697;6004.39956004396;6036.124761909542;6073.331933487313;6082.817515474543;13935;14696.485623003251;14768.483103091448;14778.187199704013;14823;2144.549644574641;2185.2570126157025;2227.4988127671145;2254.368776742515;2766.9723302766915;13250.66873328165;14791.556253312418;14964.700705985928;15436;15695;1783.188649164627;1803.5581282585852;1863.8974856382893;1888.310766570192;1984.1369004483097;115864;119199.80800192061;119951;123939;125409.74590254072;11720.179587428798;12262.141650084408;12268.386580670931;12325.137240393087;12610.621681349574;15566.143862087467;15567;15590.844091559165;15607.907446478637;15629;9310.767230819283;9324.300677449219;9358.485283309483;9375.671851485302;9390.577424015935;9511.476868772284;9603.663871764455;9638.084381983701;9647.614095436244;9691.5154242289;4866.805327786919;4966.801327946914;4968.826091086867;4979.2033274676605;4993.575546078624;2012.154894944127;2092.3618296419736;2114.6405111131144;2147.312859884853;2149.537849362395;962.9903700963041;1021.5045702834119;1058.867641544807;1062.2139616683598;1063.0538820449806;20319.796802032088;21170;21205.575888482144;21235.46911327198;21301.219737479503;914.6021480655803;1001.8246806808779;1029.1920842138884;1097;1099.6206308823444;9203.861942070875;10731.83902241467;11027.503762330714;11259.324440533594;11293.927076927679;662003;670265;670783;672275;681313;110419;113560;120220;124707.3764631171;124776;1072.5495291977231;1076.4025965589017;1076.5370890517154;1116.4417791104447;1119.1326721790676;18897.338593149172;18984.810151898306;19116.617667646846;19192.328268510537;19370;41685.79157104195;50320.74839625778;54445.72777136089;54847.17729234145;56265.15602265888;50083.7311604886;70512.58974820373;71549;81671.59164204141;82717.58641206755;8356.247937685637;8496.660133594587;8569.314454843472;8582.442141260799;8673.479591224546;9712.368696034735;13102.803457947948;13106.148100373444;13235.867641323464;13496.595102146952;11340.886591134313;11347.659570212907;11423.657290280973;11463.140264480364;11734.237274577124;9361.531923403938;11261.943690281496;11327.71680707956;11570.826437603275;11578.015868651259;11224.775504490028;11227.326360418401;11325.773484530428;11442.427878606202;11804.291742495478;8438.578071096543;8487.236148746642;8655.30757539408;8744.519051452231;8775.210231079234;8663.826723465369;11040.337579744919;11374;11550.59572914944;11662.12534059932 10:08:51 INFO - PROCESS | 1671 | |3;mootools.html;1622.9431969881052;1634.4524584264268;1796.3802488141596;1898.6487499812536;2065.2771529964507;7422.665980030898;8234.341252699785;8844.91155088449;9294.163525282731;9322.813543729122;9024.909750902489;9046.321525885553;9121.133492318235;9130.223930965876;9160.816783664322;2223.7998580127787;2579.5743702289146;2592.6629538160014;2607.2308668942705;2618.6988496322974;2438.1588352018525;2569.2292312306326;2590.1840920110103;2597.571400718879;2604.817662763607;2565.6279839423273;2580.290420134459;2610.282172402595;2618.47630473905;2624.5144648240043;2571.537123317802;2588;2603.609458581209;2611.4254863929905;2613.6863576370765;2335.7547457517057;2398.832081754278;2586.767190952823;2598.636190933271;2599.714031456538;9049.140331668481;9308.301877359158;9310.022447642968;9318.580663870074;9329.207017403462;5587.552995760329;5638.971805140989;5653.378128405872;5711.685857277848;5782.595218334718;3437.4500079987333;3578.0339308386588;3637.5453068366455;3762.6049264827075;3777.8677746279022;1043.608646757466;1055.767731099157;1057.6139709006156;1059.0733108530037;1062.9627963021335;12323.630291091282;12409.131360804748;12524.436400362005;12533.749325013448;12535.749285014339;4975.825846095442;5040.647154699136;5045.722485263273;5097.439281679012;5155.536001759785;10288.588456461657;10441.634542790965;10521.631742888962;10560.630377936888;10572.735681608021;5717.142428635655;5725.1698503716725;5750.827475175752;5752.9712351437975;5764.769409223668;4629.166749985035;5024.0956627807345;5091.949080509147;5107.846764597068;5203.11547036997;4282.272013757606;4289.871303860889;4306.138772245501;4396.428464299621;4421.11577684458;1417.4401111560876;1435.5119259451837;1444.4799872046055;1457.4898785425016;1457.613732360904;906.9388815086364;909.5906841921162;929.716436486878;975.3708857786688;985.7437066362654;5348.1175606025345;5923.289205295306;6022.488088512438;6159.81520554384;6197.318294987548;486.94643589205157;508.90330837140823;1046.4296958157822;1120.624590762104;1126.9492872820742;3452.7755695879687;3886.028492876781;3983.103801644607;4013.8996525086523;4099.754014759124;9103.544822758835;10626.89373106259;10939.453027348602;11318.773624527628;11409.942950285196;10944.452777361259;10947.83578246327;10960;10966.616168434066;10973.067289280341;8518.659253629909;8602.268807151337;8688.913110868936;8714.607842647096;8789.780255493664;5974.103884417372;6042.184305118929;6071.180390647206;6115.205023347115;6127.540434467343;9868.013198680075;9881.950590247003;9970.950145249228;10062.496875156066;10086.344387614781;8326.084130745734;10065.043820837009;10444.529996150344;10522;10764;6561.540692151694;7197.136343638587;7638.357753082892;7952.005999250094;8067.515949043076;8636.438631488933;8662.610182541675;8682.392232543662;8732.47605143668;8741.519216442903;6508.511861610493;7542.170361260147;7735.613219339123;7746;7765.883511747215;7493.138289096605;7606.467547271638;7646.8088297793;7730.536167829948;7789.688412463438;7375.483716139819;7402.074740657418;7410.814729631802;7416.0729908761405;7426.220246874001;4848.933234688363;4969.453360130455;4991.850244492671;5049.116404629101;5050.671706339076;5087.4149472811105;5105.463926287686;5116.795328186831;5222.634415590872;5327.813526526553 10:08:51 INFO - PROCESS | 1671 | |4;prototype.html;342.5358639044095;342.6522080088709;345.56113735555846;350.71416795311825;356.4599631558188;6913.308669133085;7005.964970175142;7029.367356937874;7039.04972828668;7046.365827075556;5785.681787501686;6539.215294164707;6852.554583952052;6860.416864566518;6868.96965455182;4876.87807804805;4932.876678083058;5097.3373461449955;5107.182850743881;5123.615728820353;5089.134847076006;5109.284700141983;5113.897722045557;5139.717315547643;5156.53591176794;4035.497991245432;5045.899082018357;5052.8484145475695;5079.2635067915135;5092.9745351273195;5059.873503162414;5109.41241757199;5109.667871588372;5138.999999999981;5139.306193663882;4348.608625223745;4368.344748287751;4383.167198232326;4383.561643835623;4385.298352263654;6354.428101470844;6640.667966601651;6662.034005069287;6695.665216739144;6725.865482690368;5942.465178133945;5946.643201407929;5978.611390259619;5983.252093488314;5983.970080149615;6181.3509581493745;7277.89083163753;7443.144038435595;7453.962730186368;7493.662785174626;4740.976295118537;4750.548697873696;4752.168370535177;4773.164696178155;4774.856754297377;7580.848383032364;7786.1824508426935;7892.171322011163;7892.250236227549;7898.921010789876;4813.470518242991;4838.056578967067;4862.708237505761;4876.4879687633;4912.508749125059;4957.90084198314;4958.206686930074;4970.850874473772;4973.577245934136;4979.950200497949;5921.437463440966;5930.406959304035;5951.345352011275;5952.7023648817385;5973.880522389528;6809.638072385543;7422.925770742331;7468.365188958891;7480.17718051014;7525.962370188224;1495.5737614779734;1651.7274649682668;1721.3200785689833;1725.8964462132312;1729.325563030419;1065.7761870007384;1078.9784204316027;1089.2103225161695;1090.7055095124272;1092.1208427216168;7002.334778196063;7060.788176354615;7074.646267686595;7090.858182836418;7110.857782844314;7524;7643.656035478417;7750.379969602418;7754.1470438251745;7783.299503044753;5312.814051508179;7105;7131.8635191588755;7152.570845749272;7188.676509557083;3366.8316584170693;4093.2427500912427;4101.974506373406;4135.834566617362;4137;6513.446357059703;7902.683892644345;7973.9202607973175;8251.793705157419;8277.379196560281;6552.50856185788;7781.844363112819;8070.394720395876;8079.919200807916;8131.552764598004;8172.877406838783;8183;8183.181681831769;8223.463910518534;8226.791551295;7490.176080631018;7812.296893279632;7842.9215707842195;7850.2542258485355;7865.724699635485;7304.853902922018;7632.847343052997;7675.884861726967;7680.615969201629;7710.730124445842;7299.708011679686;7466.767983282697;7808.258215469521;8176.7955801105445;8201.58992050407;4846.539578740014;4875.731834748981;4878.268259761065;4885.877853053702;4906.239532872268;6887.380135787803;7198.424126070006;7793.298603125746;7818.022747156606;7847.843043138991;7263.600501972231;7468.813279667835;7500.1374841893885;7508.399328053852;7511;7455.925440745523;7458;7490.213527579525;7518.774436766906;7526.876346316436;7247.4926755126635;7299.963500182465;7303.379212766974;7321.853562928818;7353.77938661841;7430.145533263744;7491.250874912465;7501.28737769911;7506.887396688945;7529.623518824146;6179.134921111138;7132.108486439195;7151.32062454066;7206.351428371472;7351.228121047427 10:08:51 INFO - PROCESS | 1671 | |5;yui.html;728.6356821589205;763.1414658509177;770.4837758701669;776.2005134711247;782.5070205770364;14910.776338354919;15151.257605375386;15168.772468412983;15199.620009499755;15251.618709532253;14085.366158522866;14097.224652644101;14110.365033573487;14131.576052718408;14140.434382624682;786.6617354537547;921.9354645174841;955.1833182628857;956.2254573795248;965.5896244096266;899.1053901368148;923.1138107416888;925.6066171876959;936.4381371177308;939.8449255872773;967.7483854197924;968.1673760565908;972.5088830140769;1013.3058854684527;1015.3856916565483;960.4669408478256;961.3126614470617;961.3222678011984;961.3799099580766;963.0225321298888;725.0284618611087;725.0863911471583;725.3000854175693;748.0873334531863;760.6881178716754;14898.404063837434;15167.089974601558;15207.011544249588;15213.543593692208;15357.46248881295;12919.41862616175;12983.221006739532;13067.803982940264;13136.211827290394;13144.277064761434;8615.396922215448;10065.849012264822;10216.233782466345;10303;10452.68641940743;2896.826785151996;3556.76881002734;3588.5873124590485;3604.5854726706502;3676.1912379276782;65033.02450463247;73928;74513.62743186303;75998.62000690016;77477.61261193715;8769.956150219208;9660.37207581505;9716.902830971741;9814.018598140128;10498.632547860789;21384.893075534525;21638.24266150677;21682.891585541973;21687.13251469955;21713.240036598643;7643.656035478306;7706.113796913314;7719.807004824925;7755;7929.365650747926;4134.689898257643;4151.8339266429;4201.6008479194425;4210.073783767566;4482.394876691605;3429.9485507717404;3488.790672559604;3491.511188433621;3501.3872572299747;3516.9648303517147;649.5972497051858;722.9553295488074;737.7049180327912;750.7785203365021;760.3916866506772;594.2987275015523;613.4724137241968;627.9623222606658;633.3476519185247;636.4526507203801;8282.544460054754;8380.455270407405;8397;8440.493570385797;8513.318934485227;591.4765432592187;610.2615834839894;617.8177437655812;627.0594108836744;644.262319644005;3858.6720128788807;3937.055106774411;3965.6629186519467;4063.167050754588;4126.319157339066;90758.18483630422;90972.6354104689;94616;95587;96037.5198124005;74191.25808741844;74395.62802186063;75060.62469687617;78348;80399;56936.14595780984;69900.65049674718;72388.63805681044;73177;74055;8298.668053278043;8479.321654267767;8483.490990540588;8508.276796472122;8703.521306328214;48480;49560;50094.74952625213;51830;52560;65702;70357.59284814172;71351.64324178346;72318;72523.63738181275;11092.445377730919;11214.775704486028;11228.887711122785;11564.537418503502;11769;11971.461284242405;12141.392930353624;12193.329366884907;12435.191712538655;12545.372731363577;11415.828762568402;11699.181057325906;12094.939525302669;12145.514179433078;12200.938995304967;9136.49749263797;11176.16178786578;11341.149413793833;12042;12069.27584344942;8343.666253349798;10113.747156320856;11441.656750297505;11458.541658333574;11816.881831181578;9343.906560934303;9510.762230944281;9676.467794271382;9695;10207.438590877573;7915.208479152269;9588.472634004918;9692.22462203008;9833.360831546213;9867.506624668882 10:08:51 INFO - PROCESS | 1671 | __end_tp_report 10:08:51 INFO - PROCESS | 1671 | __start_cc_report 10:08:51 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,390 10:08:51 INFO - PROCESS | 1671 | __end_cc_report 10:08:51 INFO - PROCESS | 1671 | __startTimestamp1469207331130__endTimestamp 10:08:51 INFO - PROCESS | 1671 | 10:08:51 INFO - PROCESS | 1671 | ------- Summary: start ------- 10:08:51 INFO - PROCESS | 1671 | Number of tests: 6 10:08:51 INFO - PROCESS | 1671 | 10:08:51 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5987.16 Median:6192.04 stddev:634.62 (10.2%) stddev-sans-first:591.56 10:08:51 INFO - PROCESS | 1671 | Values: 2994.7 3717.0 3719.5 3749.4 3753.6 6012.5 6047.4 6097.0 6097.1 6110.6 6058.4 6075.4 6084.3 6091.2 6118.1 5403.5 5424.9 5431.6 5512.8 5541.4 5402.6 5431.5 5487.5 5530.6 5531.8 5503.1 5516.7 5519.6 5526.2 5540.1 5489.1 5493.4 5503.3 5534.7 5535.0 5339.4 5343.8 5417.6 5449.5 5518.9 5800.9 5890.0 5940.6 5944.3 5973.6 6223.5 6320.5 6334.3 6381.2 6418.6 6371.4 6397.6 6451.1 6469.9 6474.7 6168.7 6169.3 6174.4 6174.4 6199.3 6385.5 6476.5 6635.8 6638.9 6642.8 6236.5 6299.9 6323.6 6326.0 6330.4 6375.3 6426.2 6427.2 6451.1 6454.4 6224.1 6239.6 6284.6 6301.5 6307.6 6299.1 6312.8 6323.9 6332.5 6553.5 5113.2 5149.8 5156.9 5171.8 5184.1 4516.8 4605.1 4641.3 4646.0 4703.8 6049.5 6092.8 6103.0 6141.1 6175.8 6421.5 6469.9 6487.2 6506.5 6514.2 5955.9 6129.2 6180.4 6192.0 6208.5 5690.8 5691.3 5694.0 5700.8 5707.5 6693.6 6702.0 6719.1 6734.7 6738.7 6319.2 6349.9 6425.7 6448.5 6482.8 6691.2 6705.7 6712.3 6713.7 6749.9 6348.7 6364.7 6365.6 6366.5 6369.6 6191.8 6364.2 6418.0 6426.3 6494.9 6144.2 6237.8 6270.8 6275.6 6283.1 6160.6 6241.3 6242.1 6258.5 6278.8 5477.6 6093.6 6141.7 6212.1 6213.9 5987.0 6222.0 6235.8 6244.4 6254.2 6155.9 6157.9 6189.0 6194.6 6269.2 10:08:51 INFO - PROCESS | 1671 | 10:08:51 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:72933.16 Median:38694.02 stddev:165488.21 (427.7%) stddev-sans-first:165863.19 10:08:51 INFO - PROCESS | 1671 | Values: 542.4 550.7 557.5 575.7 602.0 34381.8 40746.6 40844.2 40852.0 40979.0 41233.6 41651.8 41732.0 41775.6 41822.6 8710.4 9344.9 9873.5 9875.0 9882.0 9762.9 9982.2 10004.7 10004.8 10018.3 9962.7 9967.1 9985.9 10026.8 10052.9 8987.2 9682.6 9967.9 9976.1 10030.9 8340.5 9786.3 9956.7 9966.0 10081.8 40446.8 40662.0 41387.8 41562.8 41797.2 2426.3 2893.0 3340.7 3827.3 4091.8 24777.4 27761.9 28760.0 28989.6 29413.3 2334.0 2758.6 2822.1 2838.4 2904.7 369301.0 373272.0 375655.0 377492.0 378003.0 50418.0 51781.5 59570.8 61903.8 67163.0 67726.0 74100.6 75192.9 75708.0 75741.9 15317.5 17866.8 18777.5 18828.8 19016.0 11470.5 14331.6 14492.7 14604.3 14612.3 17060.7 20277.0 20408.5 20603.2 20715.5 8381.3 8430.6 8481.4 8485.5 8517.9 963.5 1071.7 1104.2 1116.5 1126.4 30469.7 30779.0 31210.5 31512.5 31560.8 1143.5 1155.9 1164.0 1228.6 1231.7 15502.9 15849.5 15922.1 15966.8 16308.0 662146.0 803769.0 803992.0 809747.0 819187.0 65064.0 65144.3 65811.3 65909.0 65996.7 1326.3 1550.8 1551.7 1553.7 1616.1 22247.6 31295.7 31703.8 31914.5 32016.8 55605.7 55809.0 56194.0 56273.2 56434.2 605519.0 613325.0 625068.0 628675.0 629071.0 24517.5 27295.7 27931.6 28809.4 28839.4 47593.5 47895.0 48061.0 48252.8 49677.0 32905.7 38592.8 38795.2 39452.4 39758.8 38451.4 38461.4 38812.6 39335.2 39349.0 38116.8 39113.8 39210.0 39390.8 39659.8 27944.6 33813.8 34269.7 34282.7 34532.7 25675.4 25858.5 26227.7 26295.6 26302.2 10:08:51 INFO - PROCESS | 1671 | 10:08:51 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:36715.29 Median:21187.79 stddev:111194.46 (524.8%) stddev-sans-first:111472.99 10:08:51 INFO - PROCESS | 1671 | Values: 420.1 420.3 429.2 432.9 434.7 20145.8 20305.0 20997.0 21968.3 22700.5 15431.2 17277.6 18810.7 20560.0 21586.5 5185.1 5837.7 6106.8 6156.4 6156.8 5972.8 6112.6 6143.4 6151.1 6874.1 6825.4 6828.4 6829.1 6829.8 6852.6 6462.7 6710.0 6710.1 6788.6 6811.8 5935.3 6004.4 6036.1 6073.3 6082.8 13935.0 14696.5 14768.5 14778.2 14823.0 2144.5 2185.3 2227.5 2254.4 2767.0 13250.7 14791.6 14964.7 15436.0 15695.0 1783.2 1803.6 1863.9 1888.3 1984.1 115864.0 119199.8 119951.0 123939.0 125409.7 11720.2 12262.1 12268.4 12325.1 12610.6 15566.1 15567.0 15590.8 15607.9 15629.0 9310.8 9324.3 9358.5 9375.7 9390.6 9511.5 9603.7 9638.1 9647.6 9691.5 4866.8 4966.8 4968.8 4979.2 4993.6 2012.2 2092.4 2114.6 2147.3 2149.5 963.0 1021.5 1058.9 1062.2 1063.1 20319.8 21170.0 21205.6 21235.5 21301.2 914.6 1001.8 1029.2 1097.0 1099.6 9203.9 10731.8 11027.5 11259.3 11293.9 662003.0 670265.0 670783.0 672275.0 681313.0 110419.0 113560.0 120220.0 124707.4 124776.0 1072.5 1076.4 1076.5 1116.4 1119.1 18897.3 18984.8 19116.6 19192.3 19370.0 41685.8 50320.7 54445.7 54847.2 56265.2 50083.7 70512.6 71549.0 81671.6 82717.6 8356.2 8496.7 8569.3 8582.4 8673.5 9712.4 13102.8 13106.1 13235.9 13496.6 11340.9 11347.7 11423.7 11463.1 11734.2 9361.5 11261.9 11327.7 11570.8 11578.0 11224.8 11227.3 11325.8 11442.4 11804.3 8438.6 8487.2 8655.3 8744.5 8775.2 8663.8 11040.3 11374.0 11550.6 11662.1 10:08:51 INFO - PROCESS | 1671 | 10:08:51 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5925.34 Median:5043.18 stddev:3276.24 (65.0%) stddev-sans-first:3269.48 10:08:51 INFO - PROCESS | 1671 | Values: 1622.9 1634.5 1796.4 1898.6 2065.3 7422.7 8234.3 8844.9 9294.2 9322.8 9024.9 9046.3 9121.1 9130.2 9160.8 2223.8 2579.6 2592.7 2607.2 2618.7 2438.2 2569.2 2590.2 2597.6 2604.8 2565.6 2580.3 2610.3 2618.5 2624.5 2571.5 2588.0 2603.6 2611.4 2613.7 2335.8 2398.8 2586.8 2598.6 2599.7 9049.1 9308.3 9310.0 9318.6 9329.2 5587.6 5639.0 5653.4 5711.7 5782.6 3437.5 3578.0 3637.5 3762.6 3777.9 1043.6 1055.8 1057.6 1059.1 1063.0 12323.6 12409.1 12524.4 12533.7 12535.7 4975.8 5040.6 5045.7 5097.4 5155.5 10288.6 10441.6 10521.6 10560.6 10572.7 5717.1 5725.2 5750.8 5753.0 5764.8 4629.2 5024.1 5091.9 5107.8 5203.1 4282.3 4289.9 4306.1 4396.4 4421.1 1417.4 1435.5 1444.5 1457.5 1457.6 906.9 909.6 929.7 975.4 985.7 5348.1 5923.3 6022.5 6159.8 6197.3 486.9 508.9 1046.4 1120.6 1126.9 3452.8 3886.0 3983.1 4013.9 4099.8 9103.5 10626.9 10939.5 11318.8 11409.9 10944.5 10947.8 10960.0 10966.6 10973.1 8518.7 8602.3 8688.9 8714.6 8789.8 5974.1 6042.2 6071.2 6115.2 6127.5 9868.0 9882.0 9971.0 10062.5 10086.3 8326.1 10065.0 10444.5 10522.0 10764.0 6561.5 7197.1 7638.4 7952.0 8067.5 8636.4 8662.6 8682.4 8732.5 8741.5 6508.5 7542.2 7735.6 7746.0 7765.9 7493.1 7606.5 7646.8 7730.5 7789.7 7375.5 7402.1 7410.8 7416.1 7426.2 4848.9 4969.5 4991.9 5049.1 5050.7 5087.4 5105.5 5116.8 5222.6 5327.8 10:08:51 INFO - PROCESS | 1671 | 10:08:51 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:6058.86 Median:6878.17 stddev:1959.20 (28.5%) stddev-sans-first:1917.14 10:08:51 INFO - PROCESS | 1671 | Values: 342.5 342.7 345.6 350.7 356.5 6913.3 7006.0 7029.4 7039.0 7046.4 5785.7 6539.2 6852.6 6860.4 6869.0 4876.9 4932.9 5097.3 5107.2 5123.6 5089.1 5109.3 5113.9 5139.7 5156.5 4035.5 5045.9 5052.8 5079.3 5093.0 5059.9 5109.4 5109.7 5139.0 5139.3 4348.6 4368.3 4383.2 4383.6 4385.3 6354.4 6640.7 6662.0 6695.7 6725.9 5942.5 5946.6 5978.6 5983.3 5984.0 6181.4 7277.9 7443.1 7454.0 7493.7 4741.0 4750.5 4752.2 4773.2 4774.9 7580.8 7786.2 7892.2 7892.3 7898.9 4813.5 4838.1 4862.7 4876.5 4912.5 4957.9 4958.2 4970.9 4973.6 4980.0 5921.4 5930.4 5951.3 5952.7 5973.9 6809.6 7422.9 7468.4 7480.2 7526.0 1495.6 1651.7 1721.3 1725.9 1729.3 1065.8 1079.0 1089.2 1090.7 1092.1 7002.3 7060.8 7074.6 7090.9 7110.9 7524.0 7643.7 7750.4 7754.1 7783.3 5312.8 7105.0 7131.9 7152.6 7188.7 3366.8 4093.2 4102.0 4135.8 4137.0 6513.4 7902.7 7973.9 8251.8 8277.4 6552.5 7781.8 8070.4 8079.9 8131.6 8172.9 8183.0 8183.2 8223.5 8226.8 7490.2 7812.3 7842.9 7850.3 7865.7 7304.9 7632.8 7675.9 7680.6 7710.7 7299.7 7466.8 7808.3 8176.8 8201.6 4846.5 4875.7 4878.3 4885.9 4906.2 6887.4 7198.4 7793.3 7818.0 7847.8 7263.6 7468.8 7500.1 7508.4 7511.0 7455.9 7458.0 7490.2 7518.8 7526.9 7247.5 7300.0 7303.4 7321.9 7353.8 7430.1 7491.3 7501.3 7506.9 7529.6 6179.1 7132.1 7151.3 7206.4 7351.2 10:08:51 INFO - PROCESS | 1671 | 10:08:51 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18219.43 Median:640.36 stddev:25368.79 (3961.7%) stddev-sans-first:25405.96 10:08:51 INFO - PROCESS | 1671 | Values: 728.6 763.1 770.5 776.2 782.5 14910.8 15151.3 15168.8 15199.6 15251.6 14085.4 14097.2 14110.4 14131.6 14140.4 786.7 921.9 955.2 956.2 965.6 899.1 923.1 925.6 936.4 939.8 967.7 968.2 972.5 1013.3 1015.4 960.5 961.3 961.3 961.4 963.0 725.0 725.1 725.3 748.1 760.7 14898.4 15167.1 15207.0 15213.5 15357.5 12919.4 12983.2 13067.8 13136.2 13144.3 8615.4 10065.8 10216.2 10303.0 10452.7 2896.8 3556.8 3588.6 3604.6 3676.2 65033.0 73928.0 74513.6 75998.6 77477.6 8770.0 9660.4 9716.9 9814.0 10498.6 21384.9 21638.2 21682.9 21687.1 21713.2 7643.7 7706.1 7719.8 7755.0 7929.4 4134.7 4151.8 4201.6 4210.1 4482.4 3429.9 3488.8 3491.5 3501.4 3517.0 649.6 723.0 737.7 750.8 760.4 594.3 613.5 628.0 633.3 636.5 8282.5 8380.5 8397.0 8440.5 8513.3 591.5 610.3 617.8 627.1 644.3 3858.7 3937.1 3965.7 4063.2 4126.3 90758.2 90972.6 94616.0 95587.0 96037.5 74191.3 74395.6 75060.6 78348.0 80399.0 56936.1 69900.7 72388.6 73177.0 74055.0 8298.7 8479.3 8483.5 8508.3 8703.5 48480.0 49560.0 50094.7 51830.0 52560.0 65702.0 70357.6 71351.6 72318.0 72523.6 11092.4 11214.8 11228.9 11564.5 11769.0 11971.5 12141.4 12193.3 12435.2 12545.4 11415.8 11699.2 12094.9 12145.5 12200.9 9136.5 11176.2 11341.1 12042.0 12069.3 8343.7 10113.7 11441.7 11458.5 11816.9 9343.9 9510.8 9676.5 9695.0 10207.4 7915.2 9588.5 9692.2 9833.4 9867.5 10:08:51 INFO - PROCESS | 1671 | -------- Summary: end -------- 10:08:51 INFO - PROCESS | 1671 | 10:08:51 INFO - TEST-INFO | 1671: exit 0 10:08:51 INFO - TEST-OK | dromaeo_css | took 1110445ms 10:08:51 INFO - TEST-START | kraken 10:08:51 INFO - operating with platform_type : mac_ 10:08:51 INFO - Initialising browser for kraken test... 10:08:51 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpFG6uDv/profile http://localhost:49264/getInfo.html) 10:08:54 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 10:08:54 INFO - PROCESS | 1680 | colorDepth:24 10:08:54 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 10:08:54 INFO - PROCESS | 1680 | __metrics 10:08:54 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 10:08:54 INFO - TEST-INFO | 1680: exit 0 10:08:54 INFO - Browser initialized. 10:08:54 INFO - Running cycle 1/1 for kraken test... 10:08:54 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpFG6uDv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:06 INFO - PROCESS | 1684 | RSS: Main: 171053056 10:09:06 INFO - PROCESS | 1684 | 10:09:09 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 10:09:10 INFO - PROCESS | 1684 | RSS: Main: 183640064 10:09:10 INFO - PROCESS | 1684 | 10:09:12 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 10:09:13 INFO - PROCESS | 1684 | RSS: Main: 192385024 10:09:13 INFO - PROCESS | 1684 | 10:09:16 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 10:09:17 INFO - PROCESS | 1684 | RSS: Main: 196423680 10:09:17 INFO - PROCESS | 1684 | 10:09:19 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 10:09:19 INFO - PROCESS | 1684 | RSS: Main: 196620288 10:09:19 INFO - PROCESS | 1684 | 10:09:21 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:22 INFO - PROCESS | 1684 | RSS: Main: 197754880 10:09:22 INFO - PROCESS | 1684 | 10:09:25 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:26 INFO - PROCESS | 1684 | RSS: Main: 198279168 10:09:26 INFO - PROCESS | 1684 | 10:09:29 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:29 INFO - PROCESS | 1684 | RSS: Main: 197951488 10:09:29 INFO - PROCESS | 1684 | 10:09:32 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 10:09:33 INFO - PROCESS | 1684 | RSS: Main: 198012928 10:09:33 INFO - PROCESS | 1684 | 10:09:35 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:35 INFO - PROCESS | 1684 | RSS: Main: 197799936 10:09:35 INFO - PROCESS | 1684 | 10:09:37 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:38 INFO - PROCESS | 1684 | RSS: Main: 197775360 10:09:38 INFO - PROCESS | 1684 | 10:09:40 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:40 INFO - PROCESS | 1684 | RSS: Main: 197705728 10:09:40 INFO - PROCESS | 1684 | 10:09:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:44 INFO - PROCESS | 1684 | RSS: Main: 197881856 10:09:44 INFO - PROCESS | 1684 | 10:09:47 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:47 INFO - PROCESS | 1684 | RSS: Main: 197906432 10:09:47 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 10:09:49 INFO - PROCESS | 1684 | RSS: Main: 199725056 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | __start_tp_report 10:09:49 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 10:09:49 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 10:09:49 INFO - PROCESS | 1684 | |i|pagename|runs| 10:09:49 INFO - PROCESS | 1684 | |0;ai-astar;116;112;116;118;116;130;114;114;114;117 10:09:49 INFO - PROCESS | 1684 | |1;audio-beat-detection;157;123;146;198;159;139;123;147;175;151 10:09:49 INFO - PROCESS | 1684 | |2;audio-dft;190;200;195;198;201;194;199;196;196;200 10:09:49 INFO - PROCESS | 1684 | |3;audio-fft;62;79;82;141;55;58;56;60;127;56 10:09:49 INFO - PROCESS | 1684 | |4;audio-oscillator;75;83;130;75;79;86;118;80;80;120 10:09:49 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;89;96;131;85;89;85;88;96;135;84 10:09:49 INFO - PROCESS | 1684 | |6;imaging-darkroom;114;123;95;94;93;146;100;91;131;151 10:09:49 INFO - PROCESS | 1684 | |7;imaging-desaturate;91;94;91;91;124;91;145;144;116;94 10:09:49 INFO - PROCESS | 1684 | |8;json-parse-financial;58;62;64;66;63;63;88;109;98;93 10:09:49 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;63;63;68;70;65;58;85;95;96;57 10:09:49 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;81;78;83;80;79;81;81;81;83;85 10:09:49 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;129;149;149;121;129;152;122;151;185;172 10:09:49 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;166;173;164;153;215;224;170;163;169;162 10:09:49 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;70;68;69;67;68;66;68;70;69;70 10:09:49 INFO - PROCESS | 1684 | __end_tp_report 10:09:49 INFO - PROCESS | 1684 | __start_cc_report 10:09:49 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1029 10:09:49 INFO - PROCESS | 1684 | __end_cc_report 10:09:49 INFO - PROCESS | 1684 | __startTimestamp1469207389750__endTimestamp 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | ------- Summary: start ------- 10:09:49 INFO - PROCESS | 1684 | Number of tests: 14 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:116.70 Median:116.00 stddev:4.99 (4.3%) stddev-sans-first:5.29 10:09:49 INFO - PROCESS | 1684 | Values: 116.0 112.0 116.0 118.0 116.0 130.0 114.0 114.0 114.0 117.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:154.00 stddev:22.69 (14.7%) stddev-sans-first:23.98 10:09:49 INFO - PROCESS | 1684 | Values: 157.0 123.0 146.0 198.0 159.0 139.0 123.0 147.0 175.0 151.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:196.90 Median:198.50 stddev:3.38 (1.7%) stddev-sans-first:2.50 10:09:49 INFO - PROCESS | 1684 | Values: 190.0 200.0 195.0 198.0 201.0 194.0 199.0 196.0 196.0 200.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:77.60 Median:59.00 stddev:31.38 (53.2%) stddev-sans-first:32.77 10:09:49 INFO - PROCESS | 1684 | Values: 62.0 79.0 82.0 141.0 55.0 58.0 56.0 60.0 127.0 56.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:79.50 stddev:21.22 (26.7%) stddev-sans-first:21.53 10:09:49 INFO - PROCESS | 1684 | Values: 75.0 83.0 130.0 75.0 79.0 86.0 118.0 80.0 80.0 120.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:88.50 stddev:19.04 (21.5%) stddev-sans-first:19.92 10:09:49 INFO - PROCESS | 1684 | Values: 89.0 96.0 131.0 85.0 89.0 85.0 88.0 96.0 135.0 84.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:113.80 Median:121.00 stddev:22.83 (18.9%) stddev-sans-first:24.21 10:09:49 INFO - PROCESS | 1684 | Values: 114.0 123.0 95.0 94.0 93.0 146.0 100.0 91.0 131.0 151.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:108.10 Median:91.00 stddev:22.44 (24.7%) stddev-sans-first:22.93 10:09:49 INFO - PROCESS | 1684 | Values: 91.0 94.0 91.0 91.0 124.0 91.0 145.0 144.0 116.0 94.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:76.40 Median:65.00 stddev:18.58 (28.6%) stddev-sans-first:18.47 10:09:49 INFO - PROCESS | 1684 | Values: 58.0 62.0 64.0 66.0 63.0 63.0 88.0 109.0 98.0 93.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:69.00 stddev:14.63 (21.2%) stddev-sans-first:15.15 10:09:49 INFO - PROCESS | 1684 | Values: 63.0 63.0 68.0 70.0 65.0 58.0 85.0 95.0 96.0 57.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:2.04 (2.5%) stddev-sans-first:2.17 10:09:49 INFO - PROCESS | 1684 | Values: 81.0 78.0 83.0 80.0 79.0 81.0 81.0 81.0 83.0 85.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:150.00 stddev:21.23 (14.2%) stddev-sans-first:21.61 10:09:49 INFO - PROCESS | 1684 | Values: 129.0 149.0 149.0 121.0 129.0 152.0 122.0 151.0 185.0 172.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:169.50 stddev:23.70 (14.0%) stddev-sans-first:24.87 10:09:49 INFO - PROCESS | 1684 | Values: 166.0 173.0 164.0 153.0 215.0 224.0 170.0 163.0 169.0 162.0 10:09:49 INFO - PROCESS | 1684 | 10:09:49 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.35 (2.0%) stddev-sans-first:1.32 10:09:49 INFO - PROCESS | 1684 | Values: 70.0 68.0 69.0 67.0 68.0 66.0 68.0 70.0 69.0 70.0 10:09:49 INFO - PROCESS | 1684 | -------- Summary: end -------- 10:09:49 INFO - PROCESS | 1684 | 10:09:50 INFO - TEST-INFO | 1684: exit 0 10:09:50 INFO - TEST-OK | kraken | took 58730ms 10:09:50 INFO - SUITE-END | took 1169s 10:09:50 INFO - Completed test suite (00:19:29) 10:09:50 INFO - javascript benchmark 10:09:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2994.6556146043204, 3716.9628303716954, 3719.4606782016626, 3749.362608356579, 3753.5871054184036, 6012.458878700916, 6047.425494578014, 6096.969515152418, 6097.115918191865, 6110.6028108172995, 6058.394160583939, 6075.392460753922, 6084.269887613482, 6091.208142941411, 6118.082287656854, 5403.459654034595, 5424.945750542503, 5431.592630552725, 5512.834614961537, 5541.362743284513, 5402.594805389592, 5431.456854314576, 5487.451254874501, 5530.557555395579, 5531.751071201806, 5503.091989821674, 5516.668999860021, 5519.613627046108, 5526.171074338841, 5540.113581826909, 5489.1217405215375, 5493.395726470085, 5503.3395992480955, 5534.723263836792, 5534.972325138368, 5339.41266460689, 5343.759530821122, 5417.59368047398, 5449.482299181572, 5518.91721624176, 5800.88398232033, 5889.9705501472645, 5940.61386009908, 5944.316403613597, 5973.551983601204, 6223.502119830448, 6320.525960552977, 6334.3032266450655, 6381.202349706286, 6418.646974416405, 6371.362863713638, 6397.584157029778, 6451.129097571815, 6469.93530064698, 6474.74101035958, 6168.722407491674, 6169.29053158888, 6174.444300012976, 6174.44430001302, 6199.3490683478485, 6385.5210859185745, 6476.481881449473, 6635.8009259722285, 6638.867222655616, 6642.767503137367, 6236.469900058455, 6299.874002520016, 6323.5573509854785, 6326.019466982625, 6330.3669633036325, 6375.330590288046, 6426.196725409324, 6427.22873255203, 6451.096846441502, 6454.419102280817, 6224.128621992924, 6239.625622462667, 6284.591501552384, 6301.464375528039, 6307.621542707452, 6299.149614802035, 6312.842178945563, 6323.873522529524, 6332.461740751995, 6553.541252112306, 5113.207452844815, 5149.819756308511, 5156.865489592284, 5171.81898633546, 5184.11869982104, 4516.796744146522, 4605.0559635274685, 4641.280601506772, 4646.0, 4703.7883295251795, 6049.5462840287155, 6092.847678808065, 6102.967607940184, 6141.056449558148, 6175.84560385994, 6421.4541763949655, 6469.870602587922, 6487.156669632917, 6506.512011599149, 6514.185726784152, 5955.880882382328, 6129.233845769279, 6180.381961803783, 6192.040233763774, 6208.534359923024, 5690.772369105272, 5691.345495268097, 5693.971530142323, 5700.771969121189, 5707.4577915098, 6693.598384096969, 6702.0282059101155, 6719.092922455504, 6734.730610775514, 6738.73045078211, 6319.24169099711, 6349.904751428825, 6425.742970281323, 6448.5163612730175, 6482.805515834532, 6691.230508491391, 6705.698243578953, 6712.328767123248, 6713.6643167842385, 6749.93250067493, 6348.746050158126, 6364.745410183541, 6365.61806291624, 6366.4588509977175, 6369.649669268235, 6191.81424557264, 6364.172657554488, 6418.005209192583, 6426.260979987362, 6494.870102598016, 6144.2319710036245, 6237.844053898689, 6270.7805226816845, 6275.560710750204, 6283.120363149254, 6160.630362178284, 6241.251049874044, 6242.094896240111, 6258.530610204162, 6278.780242691484, 5477.561795056466, 6093.6039157454625, 6141.723622437091, 6212.06818977157, 6213.937860621336, 5986.970065149646, 6222.0, 6235.75056997715, 6244.438000579969, 6254.249490061222, 6155.876882462415, 6157.907631385622, 6189.0, 6194.566380353332, 6269.247690277196], "value": 5948.06405998306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.3871025740915, 550.7053726256454, 557.5261028126092, 575.7380391921677, 602.0427520242813, 34381.82809085957, 40746.59253407465, 40844.183116337656, 40852.0, 40979.0, 41233.58766412335, 41651.791741041256, 41732.0, 41775.58224417755, 41822.58177418233, 8710.390272680916, 9344.859827102617, 9873.506324683773, 9875.0, 9882.0, 9762.853557196613, 9982.151517121054, 10004.74988125299, 10004.799904001915, 10018.298719089667, 9962.701118966443, 9967.102960733533, 9985.850212246822, 10026.849597256047, 10052.949735251314, 8987.236084932756, 9682.56428460721, 9967.90032099677, 9976.05227503386, 10030.949845250727, 8340.457870238415, 9786.314957952945, 9956.651517196935, 9966.003399660049, 10081.798364032751, 40446.79776601098, 40662.0, 41387.7930610345, 41562.792186038874, 41797.1640567187, 2426.3206302235403, 2892.971070289312, 3340.6659334066644, 3827.32355482288, 4091.8363265469347, 24777.380565485826, 27761.86119069412, 28760.0, 28989.56515652267, 29413.26466838346, 2333.988330058356, 2758.600002999554, 2822.139247529503, 2838.4181242845166, 2904.695007024274, 369301.0, 373272.0, 375655.0, 377492.0, 378002.99999999726, 50417.999999999265, 51781.482185177665, 59570.80858382808, 61903.76192476125, 67162.98511044677, 67726.0, 74100.62949685217, 75192.87210691844, 75708.0, 75741.86387204197, 15317.540473785804, 17866.821331786774, 18777.530561736065, 18828.811711882707, 19015.954122523395, 11470.54117835294, 14331.641708957151, 14492.710145797026, 14604.34280457382, 14612.26938653063, 17060.744088838677, 20277.0, 20408.489787755127, 20603.175872965214, 20715.4821129473, 8381.287590554872, 8430.620622072021, 8481.40630155883, 8485.515034868873, 8517.850090237862, 963.5375019990444, 1071.7267096890243, 1104.1884215101893, 1116.547798141754, 1126.3973774030853, 30469.695303046687, 30779.0, 31210.53184202239, 31512.527312090337, 31560.842195788875, 1143.519721716881, 1155.930644161353, 1163.9825402618967, 1228.5638598297655, 1231.6859200903712, 15502.922485387726, 15849.52451426459, 15922.123082594851, 15966.840331596768, 16308.021518708916, 662146.0, 803769.0, 803992.0, 809747.0, 819187.0, 65064.0240396385, 65144.348556513825, 65811.34188658147, 65909.0, 65996.67001664962, 1326.3235749767496, 1550.759632257002, 1551.6586351002761, 1553.7436323006802, 1616.13536757834, 22247.555048899256, 31295.687043130187, 31703.84148079245, 31914.52128218125, 32016.839915801203, 55605.72197138988, 55809.0, 56194.0, 56273.155902662314, 56434.153487696894, 605519.0, 613325.0, 625068.0, 628675.0, 629071.0, 24517.50964980726, 27295.72704272932, 27931.581026284217, 28809.42381152407, 28839.423211536072, 47593.52406475891, 47895.0, 48061.0, 48252.758736206095, 49677.0, 32905.67094329122, 38592.80703596464, 38795.22409551737, 39452.40821387739, 39758.80120599378, 38451.42322865103, 38461.423078653286, 38812.6118738809, 39335.213295734495, 39349.01627459336, 38116.809415952746, 39113.80443097766, 39210.0, 39390.80304598458, 39659.80170099131, 27944.580831287953, 33813.830930845186, 34269.65730342665, 34282.65717342795, 34532.65467345295, 25675.35811604725, 25858.482830342913, 26227.73772262253, 26295.60556591691, 26302.21093367202], "value": 20587.95036723804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.0737374090132, 420.3002001667222, 429.22310617781807, 432.902596915694, 434.6913691279192, 20145.798542014574, 20304.984750762476, 20997.0, 21968.340949771533, 22700.524465909704, 15431.151286679227, 17277.568060798487, 18810.717839232388, 20560.0, 21586.460338491546, 5185.092608793465, 5837.708114594253, 6106.786262480814, 6156.38436156383, 6156.815295541141, 5972.761089556434, 6112.633242005494, 6143.354947730491, 6151.138840562325, 6874.10636617239, 6825.3857152856235, 6828.419584335337, 6829.146356705412, 6829.760958366458, 6852.588844669311, 6462.675151593912, 6710.0, 6710.127683401175, 6788.592684438925, 6811.795646130624, 5935.347111817697, 6004.39956004396, 6036.124761909542, 6073.331933487313, 6082.817515474543, 13935.0, 14696.485623003251, 14768.483103091448, 14778.187199704013, 14823.0, 2144.549644574641, 2185.2570126157025, 2227.4988127671145, 2254.368776742515, 2766.9723302766915, 13250.66873328165, 14791.556253312418, 14964.700705985928, 15436.0, 15695.0, 1783.188649164627, 1803.5581282585852, 1863.8974856382893, 1888.310766570192, 1984.1369004483097, 115864.0, 119199.80800192061, 119951.0, 123939.0, 125409.74590254072, 11720.179587428798, 12262.141650084408, 12268.386580670931, 12325.137240393087, 12610.621681349574, 15566.143862087467, 15567.0, 15590.844091559165, 15607.907446478637, 15629.0, 9310.767230819283, 9324.300677449219, 9358.485283309483, 9375.671851485302, 9390.577424015935, 9511.476868772284, 9603.663871764455, 9638.084381983701, 9647.614095436244, 9691.5154242289, 4866.805327786919, 4966.801327946914, 4968.826091086867, 4979.2033274676605, 4993.575546078624, 2012.154894944127, 2092.3618296419736, 2114.6405111131144, 2147.312859884853, 2149.537849362395, 962.9903700963041, 1021.5045702834119, 1058.867641544807, 1062.2139616683598, 1063.0538820449806, 20319.796802032088, 21170.0, 21205.575888482144, 21235.46911327198, 21301.219737479503, 914.6021480655803, 1001.8246806808779, 1029.1920842138884, 1097.0, 1099.6206308823444, 9203.861942070875, 10731.83902241467, 11027.503762330714, 11259.324440533594, 11293.927076927679, 662003.0, 670265.0, 670783.0, 672275.0, 681313.0, 110419.0, 113560.0, 120220.0, 124707.3764631171, 124776.0, 1072.5495291977231, 1076.4025965589017, 1076.5370890517154, 1116.4417791104447, 1119.1326721790676, 18897.338593149172, 18984.810151898306, 19116.617667646846, 19192.328268510537, 19370.0, 41685.79157104195, 50320.74839625778, 54445.72777136089, 54847.17729234145, 56265.15602265888, 50083.7311604886, 70512.58974820373, 71549.0, 81671.59164204141, 82717.58641206755, 8356.247937685637, 8496.660133594587, 8569.314454843472, 8582.442141260799, 8673.479591224546, 9712.368696034735, 13102.803457947948, 13106.148100373444, 13235.867641323464, 13496.595102146952, 11340.886591134313, 11347.659570212907, 11423.657290280973, 11463.140264480364, 11734.237274577124, 9361.531923403938, 11261.943690281496, 11327.71680707956, 11570.826437603275, 11578.015868651259, 11224.775504490028, 11227.326360418401, 11325.773484530428, 11442.427878606202, 11804.291742495478, 8438.578071096543, 8487.236148746642, 8655.30757539408, 8744.519051452231, 8775.210231079234, 8663.826723465369, 11040.337579744919, 11374.0, 11550.59572914944, 11662.12534059932], "value": 9916.697602283235, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1622.9431969881052, 1634.4524584264268, 1796.3802488141596, 1898.6487499812536, 2065.2771529964507, 7422.665980030898, 8234.341252699785, 8844.91155088449, 9294.163525282731, 9322.813543729122, 9024.909750902489, 9046.321525885553, 9121.133492318235, 9130.223930965876, 9160.816783664322, 2223.7998580127787, 2579.5743702289146, 2592.6629538160014, 2607.2308668942705, 2618.6988496322974, 2438.1588352018525, 2569.2292312306326, 2590.1840920110103, 2597.571400718879, 2604.817662763607, 2565.6279839423273, 2580.290420134459, 2610.282172402595, 2618.47630473905, 2624.5144648240043, 2571.537123317802, 2588.0, 2603.609458581209, 2611.4254863929905, 2613.6863576370765, 2335.7547457517057, 2398.832081754278, 2586.767190952823, 2598.636190933271, 2599.714031456538, 9049.140331668481, 9308.301877359158, 9310.022447642968, 9318.580663870074, 9329.207017403462, 5587.552995760329, 5638.971805140989, 5653.378128405872, 5711.685857277848, 5782.595218334718, 3437.4500079987333, 3578.0339308386588, 3637.5453068366455, 3762.6049264827075, 3777.8677746279022, 1043.608646757466, 1055.767731099157, 1057.6139709006156, 1059.0733108530037, 1062.9627963021335, 12323.630291091282, 12409.131360804748, 12524.436400362005, 12533.749325013448, 12535.749285014339, 4975.825846095442, 5040.647154699136, 5045.722485263273, 5097.439281679012, 5155.536001759785, 10288.588456461657, 10441.634542790965, 10521.631742888962, 10560.630377936888, 10572.735681608021, 5717.142428635655, 5725.1698503716725, 5750.827475175752, 5752.9712351437975, 5764.769409223668, 4629.166749985035, 5024.0956627807345, 5091.949080509147, 5107.846764597068, 5203.11547036997, 4282.272013757606, 4289.871303860889, 4306.138772245501, 4396.428464299621, 4421.11577684458, 1417.4401111560876, 1435.5119259451837, 1444.4799872046055, 1457.4898785425016, 1457.613732360904, 906.9388815086364, 909.5906841921162, 929.716436486878, 975.3708857786688, 985.7437066362654, 5348.1175606025345, 5923.289205295306, 6022.488088512438, 6159.81520554384, 6197.318294987548, 486.94643589205157, 508.90330837140823, 1046.4296958157822, 1120.624590762104, 1126.9492872820742, 3452.7755695879687, 3886.028492876781, 3983.103801644607, 4013.8996525086523, 4099.754014759124, 9103.544822758835, 10626.89373106259, 10939.453027348602, 11318.773624527628, 11409.942950285196, 10944.452777361259, 10947.83578246327, 10960.0, 10966.616168434066, 10973.067289280341, 8518.659253629909, 8602.268807151337, 8688.913110868936, 8714.607842647096, 8789.780255493664, 5974.103884417372, 6042.184305118929, 6071.180390647206, 6115.205023347115, 6127.540434467343, 9868.013198680075, 9881.950590247003, 9970.950145249228, 10062.496875156066, 10086.344387614781, 8326.084130745734, 10065.043820837009, 10444.529996150344, 10522.0, 10764.0, 6561.540692151694, 7197.136343638587, 7638.357753082892, 7952.005999250094, 8067.515949043076, 8636.438631488933, 8662.610182541675, 8682.392232543662, 8732.47605143668, 8741.519216442903, 6508.511861610493, 7542.170361260147, 7735.613219339123, 7746.0, 7765.883511747215, 7493.138289096605, 7606.467547271638, 7646.8088297793, 7730.536167829948, 7789.688412463438, 7375.483716139819, 7402.074740657418, 7410.814729631802, 7416.0729908761405, 7426.220246874001, 4848.933234688363, 4969.453360130455, 4991.850244492671, 5049.116404629101, 5050.671706339076, 5087.4149472811105, 5105.463926287686, 5116.795328186831, 5222.634415590872, 5327.813526526553], "value": 4786.53032134082, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.5358639044095, 342.6522080088709, 345.56113735555846, 350.71416795311825, 356.4599631558188, 6913.308669133085, 7005.964970175142, 7029.367356937874, 7039.04972828668, 7046.365827075556, 5785.681787501686, 6539.215294164707, 6852.554583952052, 6860.416864566518, 6868.96965455182, 4876.87807804805, 4932.876678083058, 5097.3373461449955, 5107.182850743881, 5123.615728820353, 5089.134847076006, 5109.284700141983, 5113.897722045557, 5139.717315547643, 5156.53591176794, 4035.497991245432, 5045.899082018357, 5052.8484145475695, 5079.2635067915135, 5092.9745351273195, 5059.873503162414, 5109.41241757199, 5109.667871588372, 5138.999999999981, 5139.306193663882, 4348.608625223745, 4368.344748287751, 4383.167198232326, 4383.561643835623, 4385.298352263654, 6354.428101470844, 6640.667966601651, 6662.034005069287, 6695.665216739144, 6725.865482690368, 5942.465178133945, 5946.643201407929, 5978.611390259619, 5983.252093488314, 5983.970080149615, 6181.3509581493745, 7277.89083163753, 7443.144038435595, 7453.962730186368, 7493.662785174626, 4740.976295118537, 4750.548697873696, 4752.168370535177, 4773.164696178155, 4774.856754297377, 7580.848383032364, 7786.1824508426935, 7892.171322011163, 7892.250236227549, 7898.921010789876, 4813.470518242991, 4838.056578967067, 4862.708237505761, 4876.4879687633, 4912.508749125059, 4957.90084198314, 4958.206686930074, 4970.850874473772, 4973.577245934136, 4979.950200497949, 5921.437463440966, 5930.406959304035, 5951.345352011275, 5952.7023648817385, 5973.880522389528, 6809.638072385543, 7422.925770742331, 7468.365188958891, 7480.17718051014, 7525.962370188224, 1495.5737614779734, 1651.7274649682668, 1721.3200785689833, 1725.8964462132312, 1729.325563030419, 1065.7761870007384, 1078.9784204316027, 1089.2103225161695, 1090.7055095124272, 1092.1208427216168, 7002.334778196063, 7060.788176354615, 7074.646267686595, 7090.858182836418, 7110.857782844314, 7524.0, 7643.656035478417, 7750.379969602418, 7754.1470438251745, 7783.299503044753, 5312.814051508179, 7105.0, 7131.8635191588755, 7152.570845749272, 7188.676509557083, 3366.8316584170693, 4093.2427500912427, 4101.974506373406, 4135.834566617362, 4137.0, 6513.446357059703, 7902.683892644345, 7973.9202607973175, 8251.793705157419, 8277.379196560281, 6552.50856185788, 7781.844363112819, 8070.394720395876, 8079.919200807916, 8131.552764598004, 8172.877406838783, 8183.0, 8183.181681831769, 8223.463910518534, 8226.791551295, 7490.176080631018, 7812.296893279632, 7842.9215707842195, 7850.2542258485355, 7865.724699635485, 7304.853902922018, 7632.847343052997, 7675.884861726967, 7680.615969201629, 7710.730124445842, 7299.708011679686, 7466.767983282697, 7808.258215469521, 8176.7955801105445, 8201.58992050407, 4846.539578740014, 4875.731834748981, 4878.268259761065, 4885.877853053702, 4906.239532872268, 6887.380135787803, 7198.424126070006, 7793.298603125746, 7818.022747156606, 7847.843043138991, 7263.600501972231, 7468.813279667835, 7500.1374841893885, 7508.399328053852, 7511.0, 7455.925440745523, 7458.0, 7490.213527579525, 7518.774436766906, 7526.876346316436, 7247.4926755126635, 7299.963500182465, 7303.379212766974, 7321.853562928818, 7353.77938661841, 7430.145533263744, 7491.250874912465, 7501.28737769911, 7506.887396688945, 7529.623518824146, 6179.134921111138, 7132.108486439195, 7151.32062454066, 7206.351428371472, 7351.228121047427], "value": 5400.889498933103, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.6356821589205, 763.1414658509177, 770.4837758701669, 776.2005134711247, 782.5070205770364, 14910.776338354919, 15151.257605375386, 15168.772468412983, 15199.620009499755, 15251.618709532253, 14085.366158522866, 14097.224652644101, 14110.365033573487, 14131.576052718408, 14140.434382624682, 786.6617354537547, 921.9354645174841, 955.1833182628857, 956.2254573795248, 965.5896244096266, 899.1053901368148, 923.1138107416888, 925.6066171876959, 936.4381371177308, 939.8449255872773, 967.7483854197924, 968.1673760565908, 972.5088830140769, 1013.3058854684527, 1015.3856916565483, 960.4669408478256, 961.3126614470617, 961.3222678011984, 961.3799099580766, 963.0225321298888, 725.0284618611087, 725.0863911471583, 725.3000854175693, 748.0873334531863, 760.6881178716754, 14898.404063837434, 15167.089974601558, 15207.011544249588, 15213.543593692208, 15357.46248881295, 12919.41862616175, 12983.221006739532, 13067.803982940264, 13136.211827290394, 13144.277064761434, 8615.396922215448, 10065.849012264822, 10216.233782466345, 10303.0, 10452.68641940743, 2896.826785151996, 3556.76881002734, 3588.5873124590485, 3604.5854726706502, 3676.1912379276782, 65033.02450463247, 73928.0, 74513.62743186303, 75998.62000690016, 77477.61261193715, 8769.956150219208, 9660.37207581505, 9716.902830971741, 9814.018598140128, 10498.632547860789, 21384.893075534525, 21638.24266150677, 21682.891585541973, 21687.13251469955, 21713.240036598643, 7643.656035478306, 7706.113796913314, 7719.807004824925, 7755.0, 7929.365650747926, 4134.689898257643, 4151.8339266429, 4201.6008479194425, 4210.073783767566, 4482.394876691605, 3429.9485507717404, 3488.790672559604, 3491.511188433621, 3501.3872572299747, 3516.9648303517147, 649.5972497051858, 722.9553295488074, 737.7049180327912, 750.7785203365021, 760.3916866506772, 594.2987275015523, 613.4724137241968, 627.9623222606658, 633.3476519185247, 636.4526507203801, 8282.544460054754, 8380.455270407405, 8397.0, 8440.493570385797, 8513.318934485227, 591.4765432592187, 610.2615834839894, 617.8177437655812, 627.0594108836744, 644.262319644005, 3858.6720128788807, 3937.055106774411, 3965.6629186519467, 4063.167050754588, 4126.319157339066, 90758.18483630422, 90972.6354104689, 94616.0, 95587.0, 96037.5198124005, 74191.25808741844, 74395.62802186063, 75060.62469687617, 78348.0, 80399.0, 56936.14595780984, 69900.65049674718, 72388.63805681044, 73177.0, 74055.0, 8298.668053278043, 8479.321654267767, 8483.490990540588, 8508.276796472122, 8703.521306328214, 48480.0, 49560.0, 50094.74952625213, 51830.0, 52560.0, 65702.0, 70357.59284814172, 71351.64324178346, 72318.0, 72523.63738181275, 11092.445377730919, 11214.775704486028, 11228.887711122785, 11564.537418503502, 11769.0, 11971.461284242405, 12141.392930353624, 12193.329366884907, 12435.191712538655, 12545.372731363577, 11415.828762568402, 11699.181057325906, 12094.939525302669, 12145.514179433078, 12200.938995304967, 9136.49749263797, 11176.16178786578, 11341.149413793833, 12042.0, 12069.27584344942, 8343.666253349798, 10113.747156320856, 11441.656750297505, 11458.541658333574, 11816.881831181578, 9343.906560934303, 9510.762230944281, 9676.467794271382, 9695.0, 10207.438590877573, 7915.208479152269, 9588.472634004918, 9692.22462203008, 9833.360831546213, 9867.506624668882], "value": 7019.488176716783, "unit": "score"}], "name": "dromaeo_css", "value": 7771.958995693052, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 116.0, 118.0, 116.0, 130.0, 114.0, 114.0, 114.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 146.0, 198.0, 159.0, 139.0, 123.0, 147.0, 175.0, 151.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 200.0, 195.0, 198.0, 201.0, 194.0, 199.0, 196.0, 196.0, 200.0], "value": 196.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 79.0, 82.0, 141.0, 55.0, 58.0, 56.0, 60.0, 127.0, 56.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 130.0, 75.0, 79.0, 86.0, 118.0, 80.0, 80.0, 120.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 96.0, 131.0, 85.0, 89.0, 85.0, 88.0, 96.0, 135.0, 84.0], "value": 97.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 123.0, 95.0, 94.0, 93.0, 146.0, 100.0, 91.0, 131.0, 151.0], "value": 113.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 91.0, 91.0, 124.0, 91.0, 145.0, 144.0, 116.0, 94.0], "value": 108.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 64.0, 66.0, 63.0, 63.0, 88.0, 109.0, 98.0, 93.0], "value": 76.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 68.0, 70.0, 65.0, 58.0, 85.0, 95.0, 96.0, 57.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 83.0, 80.0, 79.0, 81.0, 81.0, 81.0, 83.0, 85.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 149.0, 149.0, 121.0, 129.0, 152.0, 122.0, 151.0, 185.0, 172.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 173.0, 164.0, 153.0, 215.0, 224.0, 170.0, 163.0, 169.0, 162.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 67.0, 68.0, 66.0, 68.0, 70.0, 69.0, 70.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1575.2000000000003, "alertThreshold": 2.0}]} 10:09:51 INFO - Return code: 0 10:09:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:09:51 ERROR - # TBPL SUCCESS # 10:09:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:51 INFO - 2016-07-22 10:09:51.095 screenresolution[1689:11214] starting screenresolution argv=screenresolution get 10:09:51 INFO - 2016-07-22 10:09:51.097 screenresolution[1689:11214] Display 0: 1600x1200x32@60 10:09:51 INFO - 2016-07-22 10:09:51.103 screenresolution[1690:11217] starting screenresolution argv=screenresolution list 10:09:51 INFO - Available Modes on Display 0 10:09:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:51 INFO - Intel Iris: 10:09:51 INFO - Chipset Model: Intel Iris 10:09:51 INFO - Type: GPU 10:09:51 INFO - Bus: Built-In 10:09:51 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:51 INFO - Vendor: Intel (0x8086) 10:09:51 INFO - Device ID: 0x0a2e 10:09:51 INFO - Revision ID: 0x0009 10:09:51 INFO - Displays: 10:09:51 INFO - Display: 10:09:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:51 INFO - Display Serial Number: 1600x1200 60 10:09:51 INFO - Main Display: Yes 10:09:51 INFO - Mirror: Off 10:09:51 INFO - Online: Yes 10:09:51 INFO - Rotation: Supported 10:09:51 INFO - Return code: 0 10:09:51 INFO - Running post-action listener: _resource_record_post_action 10:09:51 INFO - Running post-run listener: _resource_record_post_run 10:09:52 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 31936000; Write bytes: 497577984; Read time: 199; Write time: 1585 10:09:52 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193442304; Write bytes: 188462592; Read time: 17799; Write time: 438 10:09:52 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 30154240; Write bytes: 299371008; Read time: 184; Write time: 1118 10:09:52 INFO - Running post-run listener: _upload_blobber_files 10:09:52 INFO - Blob upload gear active. 10:09:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:52 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 10:09:52 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'] 10:09:52 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 10:09:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:09:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:09:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:54 INFO - (blobuploader) - INFO - Done attempting. 10:09:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:55 INFO - (blobuploader) - INFO - Done attempting. 10:09:55 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:55 INFO - Return code: 0 10:09:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/686edd2737abf2794a3b32bea4b0022a76fcec7fb17e096e050518f1745d90a3cb6e122cc7564c41c9cc3d00afc45a8a550eb2edff6992a812e5808e839aef8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e3fe3b6103bde7cb3afbfb32d309c145c516fa2b1682a88000173fa062c2bd47bf3d99aacee1a780d0672b7f991fc3a1082b6a8be21c5da9be691ace4302674"} 10:09:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:55 INFO - Contents: 10:09:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/686edd2737abf2794a3b32bea4b0022a76fcec7fb17e096e050518f1745d90a3cb6e122cc7564c41c9cc3d00afc45a8a550eb2edff6992a812e5808e839aef8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e3fe3b6103bde7cb3afbfb32d309c145c516fa2b1682a88000173fa062c2bd47bf3d99aacee1a780d0672b7f991fc3a1082b6a8be21c5da9be691ace4302674"} 10:09:55 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:55 INFO - Copying logs to upload dir... 10:09:55 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.880041 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-22 10:09:55.468938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 10:09:55.476805) ========= 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.tEUv21xtlq/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.5NGsqE2OYa/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/686edd2737abf2794a3b32bea4b0022a76fcec7fb17e096e050518f1745d90a3cb6e122cc7564c41c9cc3d00afc45a8a550eb2edff6992a812e5808e839aef8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e3fe3b6103bde7cb3afbfb32d309c145c516fa2b1682a88000173fa062c2bd47bf3d99aacee1a780d0672b7f991fc3a1082b6a8be21c5da9be691ace4302674"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011113 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1469183278/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/686edd2737abf2794a3b32bea4b0022a76fcec7fb17e096e050518f1745d90a3cb6e122cc7564c41c9cc3d00afc45a8a550eb2edff6992a812e5808e839aef8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e3fe3b6103bde7cb3afbfb32d309c145c516fa2b1682a88000173fa062c2bd47bf3d99aacee1a780d0672b7f991fc3a1082b6a8be21c5da9be691ace4302674"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 10:09:55.512856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 10:09:55.513232) ========= 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.tEUv21xtlq/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.5NGsqE2OYa/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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.005289 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 10:09:55.562089) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 10:09:55.565487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 10:09:55.565874) ========= ========= Total master_lag: 0.19 =========