builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0163 starttime: 1467174806.48 results: success (0) buildid: 20160628145857 builduid: ea0026bc7646423c90129e3e81e3bfa0 revision: 2b22de79c849b6c915b01f0d306699261b2fdee3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:26.477982) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:26.478496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:26.478856) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:26.504087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:26.504532) ========= 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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-06-28 21:33:26-- 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% 34.3M=0s 2016-06-28 21:33:26 (34.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122605 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:26.651197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:26.651552) ========= 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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.027987 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:26.702149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 21:33:26.702534) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2b22de79c849b6c915b01f0d306699261b2fdee3 --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 2b22de79c849b6c915b01f0d306699261b2fdee3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TxyN8nHzey/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.J6x1pHX8Ur/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-06-28 21:33:26,775 truncating revision to first 12 chars 2016-06-28 21:33:26,775 Setting DEBUG logging. 2016-06-28 21:33:26,775 attempt 1/10 2016-06-28 21:33:26,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2b22de79c849?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 21:33:27,874 unpacking tar archive at: mozilla-beta-2b22de79c849/testing/mozharness/ program finished with exit code 0 elapsedTime=1.559803 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 21:33:28.283995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:28.284329) ========= script_repo_revision: 2b22de79c849b6c915b01f0d306699261b2fdee3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:28.284736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:28.285001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 21:33:28.302680) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-28 21:33:28.303022) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TxyN8nHzey/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.J6x1pHX8Ur/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 21:33:28 INFO - MultiFileLogger online at 20160628 21:33:28 in /builds/slave/test 21:33:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:33:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:33:28 INFO - {'append_to_log': False, 21:33:28 INFO - 'base_work_dir': '/builds/slave/test', 21:33:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:33:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:33:28 INFO - 'branch': 'Mozilla-Beta', 21:33:28 INFO - 'buildbot_json_path': 'buildprops.json', 21:33:28 INFO - 'config_files': ('talos/mac_config.py',), 21:33:28 INFO - 'default_actions': ('clobber', 21:33:28 INFO - 'read-buildbot-config', 21:33:28 INFO - 'download-and-extract', 21:33:28 INFO - 'populate-webroot', 21:33:28 INFO - 'create-virtualenv', 21:33:28 INFO - 'install', 21:33:28 INFO - 'run-tests'), 21:33:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:33:28 INFO - 'download_minidump_stackwalk': True, 21:33:28 INFO - 'download_symbols': 'ondemand', 21:33:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:33:28 INFO - 'tooltool.py': '/tools/tooltool.py', 21:33:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:33:28 INFO - '/tools/misc-python/virtualenv.py')}, 21:33:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:33:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:33:28 INFO - 'installer_path': 'installer.exe', 21:33:28 INFO - 'log_level': 'info', 21:33:28 INFO - 'log_name': 'talos', 21:33:28 INFO - 'log_to_console': True, 21:33:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:33:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:33:28 INFO - 'opt_config_files': (), 21:33:28 INFO - 'pip_index': False, 21:33:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:33:28 INFO - 'cmd': ('bash', 21:33:28 INFO - '-c', 21:33:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:33:28 INFO - 'enabled': True, 21:33:28 INFO - 'halt_on_failure': False, 21:33:28 INFO - 'name': 'check_screen_resolution'},), 21:33:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:33:28 INFO - 'cmd': ('bash', 21:33:28 INFO - '-c', 21:33:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:33:28 INFO - 'enabled': True, 21:33:28 INFO - 'halt_on_failure': False, 21:33:28 INFO - 'name': 'check_screen_resolution'},), 21:33:28 INFO - 'run_cmd_checks_enabled': True, 21:33:28 INFO - 'sps_profile': False, 21:33:28 INFO - 'sps_profile_interval': 0, 21:33:28 INFO - 'suite': 'dromaeojs', 21:33:28 INFO - 'system_bits': '32', 21:33:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:33:28 INFO - 'title': 't-yosemite-r7-0163', 21:33:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:33:28 INFO - 'use_talos_json': True, 21:33:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:33:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:33:28 INFO - 'work_dir': 'build'} 21:33:28 INFO - ##### 21:33:28 INFO - ##### Running clobber step. 21:33:28 INFO - ##### 21:33:28 INFO - Running pre-action listener: _resource_record_pre_action 21:33:28 INFO - Running main action method: clobber 21:33:28 INFO - rmtree: /builds/slave/test/build 21:33:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:33:30 INFO - Running post-action listener: _resource_record_post_action 21:33:30 INFO - ##### 21:33:30 INFO - ##### Running read-buildbot-config step. 21:33:30 INFO - ##### 21:33:30 INFO - Running pre-action listener: _resource_record_pre_action 21:33:30 INFO - Running main action method: read_buildbot_config 21:33:30 INFO - Using buildbot properties: 21:33:30 INFO - { 21:33:30 INFO - "project": "", 21:33:30 INFO - "product": "firefox", 21:33:30 INFO - "script_repo_revision": "production", 21:33:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 21:33:30 INFO - "repository": "", 21:33:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 21:33:30 INFO - "buildid": "20160628145857", 21:33:30 INFO - "pgo_build": "False", 21:33:30 INFO - "basedir": "/builds/slave/test", 21:33:30 INFO - "buildnumber": 21, 21:33:30 INFO - "slavename": "t-yosemite-r7-0163", 21:33:30 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:33:30 INFO - "platform": "yosemite_r7", 21:33:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 21:33:30 INFO - "branch": "mozilla-beta", 21:33:30 INFO - "repo_path": "releases/mozilla-beta", 21:33:30 INFO - "revision": "2b22de79c849b6c915b01f0d306699261b2fdee3", 21:33:30 INFO - "stage_platform": "macosx64", 21:33:30 INFO - "builduid": "ea0026bc7646423c90129e3e81e3bfa0", 21:33:30 INFO - "slavebuilddir": "test" 21:33:30 INFO - } 21:33:30 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.dmg. 21:33:30 INFO - Running post-action listener: _resource_record_post_action 21:33:30 INFO - ##### 21:33:30 INFO - ##### Running download-and-extract step. 21:33:30 INFO - ##### 21:33:30 INFO - Running pre-action listener: _resource_record_pre_action 21:33:30 INFO - Running main action method: download_and_extract 21:33:30 INFO - mkdir: /builds/slave/test/build/tests 21:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:33:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.test_packages.json 21:33:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 21:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/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 21:33:30 INFO - Downloaded 1165 bytes. 21:33:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 21:33:30 INFO - Using the following test package requirements: 21:33:30 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 21:33:30 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:33:30 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 21:33:30 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:33:30 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 21:33:30 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 21:33:30 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:33:30 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 21:33:30 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 21:33:30 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:33:30 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 21:33:30 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:33:30 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 21:33:30 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:33:30 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 21:33:30 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:33:30 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 21:33:30 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 21:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:33:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.common.tests.zip 21:33:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 21:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/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 21:33:31 INFO - Downloaded 18350378 bytes. 21:33:31 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'] 21:33:31 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 21:33:34 INFO - Return code: 0 21:33:34 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 21:33: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')]} 21:33:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.common.tests.zip 21:33:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 21:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/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 21:33:35 INFO - Downloaded 18350378 bytes. 21:33:35 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'] 21:33:35 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 21:33:38 INFO - Return code: 0 21:33:38 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')]} 21:33:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.talos.tests.zip 21:33:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 21:33:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/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 21:33:38 INFO - Downloaded 10840145 bytes. 21:33:38 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'] 21:33:38 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 21:33:39 INFO - Return code: 0 21:33: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')]} 21:33:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.dmg 21:33:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 21:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 21:33:40 INFO - Downloaded 86201138 bytes. 21:33:40 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.dmg 21:33:40 INFO - mkdir: /builds/slave/test/properties 21:33:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:33:40 INFO - Writing to file /builds/slave/test/properties/build_url 21:33:40 INFO - Contents: 21:33:40 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.dmg 21:33:40 INFO - Running post-action listener: _resource_record_post_action 21:33:40 INFO - Running post-action listener: set_extra_try_arguments 21:33:40 INFO - ##### 21:33:40 INFO - ##### Running populate-webroot step. 21:33:40 INFO - ##### 21:33:40 INFO - Running pre-action listener: _resource_record_pre_action 21:33:40 INFO - Running main action method: populate_webroot 21:33:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:33:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:33:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:33:40 INFO - '--tppagecycles', 21:33:40 INFO - '7'], 21:33:40 INFO - 'tests': ['tsvgm']}}, 21:33:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:33:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:33:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:33:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:33:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:33:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:33:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:40 INFO - 'talos_options': ['--disable-e10s'], 21:33:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:33:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:33:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:40 INFO - 'talos_options': ['--disable-e10s'], 21:33:40 INFO - 'tests': ['damp', 'tps']}, 21:33:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:40 INFO - 'tests': ['damp', 'tps']}, 21:33:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:33:40 INFO - 'tests': ['dromaeo_dom']}, 21:33:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:33:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:33:40 INFO - 'tests': ['a11yr', 21:33:40 INFO - 'ts_paint', 21:33:40 INFO - 'tpaint', 21:33:40 INFO - 'sessionrestore', 21:33:40 INFO - 'sessionrestore_no_auto_restore', 21:33:40 INFO - 'tabpaint']}, 21:33:40 INFO - 'other-e10s': {'tests': ['a11yr', 21:33:40 INFO - 'ts_paint', 21:33:40 INFO - 'tpaint', 21:33:40 INFO - 'sessionrestore', 21:33:40 INFO - 'sessionrestore_no_auto_restore', 21:33:40 INFO - 'tabpaint']}, 21:33:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:33:40 INFO - 'ts_paint', 21:33:40 INFO - 'tpaint', 21:33:40 INFO - 'sessionrestore', 21:33:40 INFO - 'sessionrestore_no_auto_restore', 21:33:40 INFO - 'tabpaint']}, 21:33:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:33:40 INFO - 'ts_paint', 21:33:40 INFO - 'tpaint', 21:33:40 INFO - 'sessionrestore', 21:33:40 INFO - 'sessionrestore_no_auto_restore', 21:33:40 INFO - 'tabpaint']}, 21:33:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:33:40 INFO - 'tests': ['a11yr', 21:33:40 INFO - 'ts_paint', 21:33:40 INFO - 'tpaint', 21:33:40 INFO - 'sessionrestore', 21:33:40 INFO - 'sessionrestore_no_auto_restore', 21:33:40 INFO - 'tabpaint']}, 21:33:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:33:40 INFO - 'tests': ['a11yr', 21:33:40 INFO - 'ts_paint', 21:33:40 INFO - 'tpaint', 21:33:40 INFO - 'sessionrestore', 21:33:40 INFO - 'sessionrestore_no_auto_restore', 21:33:40 INFO - 'tabpaint']}, 21:33:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:33:40 INFO - 'tests': ['tsvgx', 21:33:40 INFO - 'tsvgr_opacity', 21:33:40 INFO - 'tart', 21:33:40 INFO - 'tscrollx', 21:33:40 INFO - 'cart']}, 21:33:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:33:40 INFO - 'tsvgr_opacity', 21:33:40 INFO - 'tart', 21:33:40 INFO - 'tscrollx', 21:33:40 INFO - 'cart']}, 21:33:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:40 INFO - 'talos_options': ['--disable-e10s'], 21:33:40 INFO - 'tests': ['tp5o']}, 21:33:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:40 INFO - 'tests': ['tp5o']}, 21:33:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:40 INFO - 'talos_options': ['--disable-e10s', 21:33:40 INFO - '--xperf_path', 21:33:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:33:40 INFO - 'tests': ['tp5n']}, 21:33:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:40 INFO - 'talos_options': ['--xperf_path', 21:33:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:33:40 INFO - 'tests': ['tp5n']}}, 21:33:40 INFO - 'talos.zip': {'path': '', 21:33:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:33:40 INFO - Running post-action listener: _resource_record_post_action 21:33:40 INFO - ##### 21:33:40 INFO - ##### Running create-virtualenv step. 21:33:40 INFO - ##### 21:33:40 INFO - Running pre-action listener: _resource_record_pre_action 21:33:40 INFO - Running main action method: create_virtualenv 21:33:40 INFO - Creating virtualenv /builds/slave/test/build/venv 21:33:40 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 21:33:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:33:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:33:40 INFO - Using real prefix '/tools/python27' 21:33:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:33:41 INFO - Installing distribute.............................................................................................................................................................................................done. 21:33:44 INFO - Installing pip.................done. 21:33:44 INFO - Return code: 0 21:33:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:33: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')]} 21:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33: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')]} 21:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10847da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc02581750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10831ce00>, '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 0x108185db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108317b20>, '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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 21:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TxyN8nHzey/Render', 21:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:44 INFO - 'HOME': '/Users/cltbld', 21:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:44 INFO - 'LOGNAME': 'cltbld', 21:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:44 INFO - 'MOZ_NO_REMOTE': '1', 21:33:44 INFO - 'NO_EM_RESTART': '1', 21:33:44 INFO - 'PAGER': '/bin/cat', 21:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:44 INFO - 'PWD': '/builds/slave/test', 21:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:44 INFO - 'SHELL': '/bin/bash', 21:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6x1pHX8Ur/Listeners', 21:33:44 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 21:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:44 INFO - 'USER': 'cltbld', 21:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:44 INFO - 'XPC_FLAGS': '0x0', 21:33:44 INFO - 'XPC_SERVICE_NAME': '0', 21:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:44 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 21:33:44 INFO - Cleaning up... 21:33:44 INFO - Return code: 0 21:33:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:33: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')]} 21:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33: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')]} 21:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10847da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc02581750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10831ce00>, '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 0x108185db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108317b20>, '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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 21:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TxyN8nHzey/Render', 21:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:44 INFO - 'HOME': '/Users/cltbld', 21:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:44 INFO - 'LOGNAME': 'cltbld', 21:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:44 INFO - 'MOZ_NO_REMOTE': '1', 21:33:44 INFO - 'NO_EM_RESTART': '1', 21:33:44 INFO - 'PAGER': '/bin/cat', 21:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:44 INFO - 'PWD': '/builds/slave/test', 21:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:44 INFO - 'SHELL': '/bin/bash', 21:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6x1pHX8Ur/Listeners', 21:33:44 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 21:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:44 INFO - 'USER': 'cltbld', 21:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:44 INFO - 'XPC_FLAGS': '0x0', 21:33:44 INFO - 'XPC_SERVICE_NAME': '0', 21:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:44 INFO - Downloading/unpacking psutil>=0.7.1 21:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:33:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:33:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:33:48 INFO - Installing collected packages: psutil 21:33:48 INFO - Running setup.py install for psutil 21:33:48 INFO - building 'psutil._psutil_osx' extension 21:33:48 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 21:33:48 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 21:33:48 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 21:33:48 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 21:33:49 INFO - building 'psutil._psutil_posix' extension 21:33:49 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 21:33:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:33:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:33:49 INFO - ^ 21:33:49 INFO - 1 warning generated. 21:33:49 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 21:33:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:33:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:33:49 INFO - Successfully installed psutil 21:33:49 INFO - Cleaning up... 21:33:49 INFO - Return code: 0 21:33:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:33: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')]} 21:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33: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')]} 21:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33: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', '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 0x10847da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc02581750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10831ce00>, '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 0x108185db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108317b20>, '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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 21:33: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:33: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 mozsystemmonitor==0.0.0 21:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TxyN8nHzey/Render', 21:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:49 INFO - 'HOME': '/Users/cltbld', 21:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:49 INFO - 'LOGNAME': 'cltbld', 21:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:49 INFO - 'MOZ_NO_REMOTE': '1', 21:33:49 INFO - 'NO_EM_RESTART': '1', 21:33:49 INFO - 'PAGER': '/bin/cat', 21:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:49 INFO - 'PWD': '/builds/slave/test', 21:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:49 INFO - 'SHELL': '/bin/bash', 21:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6x1pHX8Ur/Listeners', 21:33:49 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 21:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:49 INFO - 'USER': 'cltbld', 21:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:49 INFO - 'XPC_FLAGS': '0x0', 21:33:49 INFO - 'XPC_SERVICE_NAME': '0', 21:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:33: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 21:33: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 21:33: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 21:33: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 21:33: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 21:33: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 21:33:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:33:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:33:52 INFO - Installing collected packages: mozsystemmonitor 21:33:52 INFO - Running setup.py install for mozsystemmonitor 21:33:52 INFO - Successfully installed mozsystemmonitor 21:33:52 INFO - Cleaning up... 21:33:52 INFO - Return code: 0 21:33:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:52 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 0x10847da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc02581750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10831ce00>, '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 0x108185db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108317b20>, '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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 21:33:52 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 21:33:52 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 21:33:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TxyN8nHzey/Render', 21:33:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:52 INFO - 'HOME': '/Users/cltbld', 21:33:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:52 INFO - 'LOGNAME': 'cltbld', 21:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:52 INFO - 'MOZ_NO_REMOTE': '1', 21:33:52 INFO - 'NO_EM_RESTART': '1', 21:33:52 INFO - 'PAGER': '/bin/cat', 21:33:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:52 INFO - 'PWD': '/builds/slave/test', 21:33:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:52 INFO - 'SHELL': '/bin/bash', 21:33:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6x1pHX8Ur/Listeners', 21:33:52 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 21:33:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:52 INFO - 'USER': 'cltbld', 21:33:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:52 INFO - 'XPC_FLAGS': '0x0', 21:33:52 INFO - 'XPC_SERVICE_NAME': '0', 21:33:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:53 INFO - Downloading/unpacking blobuploader==1.2.4 21:33: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 21:33: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 21:33: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 21:33: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 21:33: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 21:33: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 21:33:55 INFO - Downloading blobuploader-1.2.4.tar.gz 21:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:33:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:33: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 21:33: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 21:33: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 21:33: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 21:33: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 21:33: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 21:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:33:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:33: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 21:33: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 21:33: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 21:33: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 21:33: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 21:33: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 21:33:56 INFO - Downloading docopt-0.6.1.tar.gz 21:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:33:56 INFO - Installing collected packages: blobuploader, requests, docopt 21:33:56 INFO - Running setup.py install for blobuploader 21:33:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:33:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:33:57 INFO - Running setup.py install for requests 21:33:57 INFO - Running setup.py install for docopt 21:33:57 INFO - Successfully installed blobuploader requests docopt 21:33:57 INFO - Cleaning up... 21:33:57 INFO - Return code: 0 21:33:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:33: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')]} 21:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33: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')]} 21:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:57 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 0x10847da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc02581750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10831ce00>, '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 0x108185db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108317b20>, '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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 21:33:57 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 21:33:57 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 21:33:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TxyN8nHzey/Render', 21:33:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:57 INFO - 'HOME': '/Users/cltbld', 21:33:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:57 INFO - 'LOGNAME': 'cltbld', 21:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:57 INFO - 'MOZ_NO_REMOTE': '1', 21:33:57 INFO - 'NO_EM_RESTART': '1', 21:33:57 INFO - 'PAGER': '/bin/cat', 21:33:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:57 INFO - 'PWD': '/builds/slave/test', 21:33:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:57 INFO - 'SHELL': '/bin/bash', 21:33:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6x1pHX8Ur/Listeners', 21:33:57 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 21:33:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:57 INFO - 'USER': 'cltbld', 21:33:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:57 INFO - 'XPC_FLAGS': '0x0', 21:33:57 INFO - 'XPC_SERVICE_NAME': '0', 21:33:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:33:58 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-50eiRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:33:58 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-wzppAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:33:58 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ATaUVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:33:58 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-tVmGDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:33:58 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-2Yo1RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:33:58 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-PVMXMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:33:58 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-44xNEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:33:58 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-kxlHxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:33:58 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-XXbrmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:33:58 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-zPPQvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:33:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-dHTyRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:33:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bRl8FL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:33:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-HEs0PJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:33:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-77aWOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-XGvhgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:33:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-X_kL6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:33:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-38lK_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:33:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:33:59 INFO - Running setup.py install for manifestparser 21:33:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:33:59 INFO - Running setup.py install for mozcrash 21:34:00 INFO - Running setup.py install for mozdebug 21:34:00 INFO - Running setup.py install for mozdevice 21:34:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:34:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:34:00 INFO - Running setup.py install for mozfile 21:34:00 INFO - Running setup.py install for mozhttpd 21:34:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:34:00 INFO - Running setup.py install for mozinfo 21:34:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:34:00 INFO - Running setup.py install for mozInstall 21:34:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:34:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:34:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:34:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:34:00 INFO - Running setup.py install for mozleak 21:34:01 INFO - Running setup.py install for mozlog 21:34:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:34:01 INFO - Running setup.py install for moznetwork 21:34:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:34:01 INFO - Running setup.py install for mozprocess 21:34:01 INFO - Running setup.py install for mozprofile 21:34:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:34:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:34:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:34:01 INFO - Running setup.py install for mozrunner 21:34:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:34:02 INFO - Running setup.py install for mozscreenshot 21:34:02 INFO - Running setup.py install for moztest 21:34:02 INFO - Running setup.py install for mozversion 21:34:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:34:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:34:02 INFO - Cleaning up... 21:34:02 INFO - Return code: 0 21:34:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:02 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 0x10847da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc02581750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10831ce00>, '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 0x108185db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108317b20>, '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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 21:34:02 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 21:34:02 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 21:34:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TxyN8nHzey/Render', 21:34:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:02 INFO - 'HOME': '/Users/cltbld', 21:34:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:02 INFO - 'LOGNAME': 'cltbld', 21:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:02 INFO - 'MOZ_NO_REMOTE': '1', 21:34:02 INFO - 'NO_EM_RESTART': '1', 21:34:02 INFO - 'PAGER': '/bin/cat', 21:34:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:02 INFO - 'PWD': '/builds/slave/test', 21:34:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:02 INFO - 'SHELL': '/bin/bash', 21:34:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6x1pHX8Ur/Listeners', 21:34:02 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 21:34:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:02 INFO - 'USER': 'cltbld', 21:34:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:02 INFO - 'XPC_FLAGS': '0x0', 21:34:02 INFO - 'XPC_SERVICE_NAME': '0', 21:34:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:34:02 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-dmKZjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:34:03 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)) 21:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:34:03 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-elVHDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:34:03 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)) 21:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:34:03 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-9AAcvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:34:03 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)) 21:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:34:03 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hNjWCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:34:03 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)) 21:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:34:03 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-VCIuBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:34:03 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)) 21:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:34:03 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Yam1Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:34:03 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)) 21:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:34:03 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-mG35TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:34:03 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)) 21:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:34:03 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DWCfpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:34:03 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)) 21:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:34:03 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-mciCxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:34:03 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)) 21:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:34:03 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-1b7jhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:34:04 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)) 21:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:34:04 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bQLD2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:34:04 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)) 21:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:34:04 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ROU6eE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:34:04 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)) 21:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:34:04 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-UvXweN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:34:04 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)) 21:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:34:04 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-lAnhha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:34:04 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)) 21:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:04 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hdqffb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:04 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)) 21:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:34:04 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Ym1d2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:34:04 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)) 21:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:34:04 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-dvwDYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:34:04 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)) 21:34:04 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)) 21:34:04 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)) 21:34:04 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)) 21:34:04 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)) 21:34:04 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)) 21:34:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:07 INFO - Downloading blessings-1.6.tar.gz 21:34:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:34:07 INFO - Installing collected packages: blessings 21:34:07 INFO - Running setup.py install for blessings 21:34:07 INFO - Successfully installed blessings 21:34:07 INFO - Cleaning up... 21:34:07 INFO - Return code: 0 21:34:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:34:07 INFO - Reading from file tmpfile_stdout 21:34:07 INFO - Current package versions: 21:34:07 INFO - blessings == 1.6 21:34:07 INFO - blobuploader == 1.2.4 21:34:07 INFO - docopt == 0.6.1 21:34:07 INFO - manifestparser == 1.1 21:34:07 INFO - mozInstall == 1.12 21:34:07 INFO - mozcrash == 0.17 21:34:07 INFO - mozdebug == 0.1 21:34:07 INFO - mozdevice == 0.48 21:34:07 INFO - mozfile == 1.2 21:34:07 INFO - mozhttpd == 0.7 21:34:07 INFO - mozinfo == 0.9 21:34:07 INFO - mozleak == 0.1 21:34:07 INFO - mozlog == 3.1 21:34:07 INFO - moznetwork == 0.27 21:34:07 INFO - mozprocess == 0.22 21:34:07 INFO - mozprofile == 0.28 21:34:07 INFO - mozrunner == 6.11 21:34:07 INFO - mozscreenshot == 0.1 21:34:07 INFO - mozsystemmonitor == 0.0 21:34:07 INFO - moztest == 0.7 21:34:07 INFO - mozversion == 1.4 21:34:07 INFO - psutil == 3.1.1 21:34:07 INFO - requests == 1.2.3 21:34:07 INFO - wsgiref == 0.1.2 21:34:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:07 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 0x10847da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc02581750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10831ce00>, '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 0x108185db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108317b20>, '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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 21:34:07 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 21:34:07 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 21:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TxyN8nHzey/Render', 21:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:07 INFO - 'HOME': '/Users/cltbld', 21:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:07 INFO - 'LOGNAME': 'cltbld', 21:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:07 INFO - 'MOZ_NO_REMOTE': '1', 21:34:07 INFO - 'NO_EM_RESTART': '1', 21:34:07 INFO - 'PAGER': '/bin/cat', 21:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:07 INFO - 'PWD': '/builds/slave/test', 21:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:07 INFO - 'SHELL': '/bin/bash', 21:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6x1pHX8Ur/Listeners', 21:34:07 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 21:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:07 INFO - 'USER': 'cltbld', 21:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:07 INFO - 'XPC_FLAGS': '0x0', 21:34:07 INFO - 'XPC_SERVICE_NAME': '0', 21:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:08 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)) 21:34:08 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)) 21:34:08 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)) 21:34:08 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)) 21:34:08 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)) 21:34:08 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)) 21:34:08 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)) 21:34:08 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)) 21:34:08 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)) 21:34:08 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)) 21:34:08 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)) 21:34:08 INFO - Cleaning up... 21:34:08 INFO - Return code: 0 21:34:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:34:08 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')]} 21:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:08 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')]} 21:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:08 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 0x10847da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc02581750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10831ce00>, '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 0x108185db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108317b20>, '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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 21:34:08 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 21:34:08 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 21:34:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TxyN8nHzey/Render', 21:34:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:08 INFO - 'HOME': '/Users/cltbld', 21:34:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:08 INFO - 'LOGNAME': 'cltbld', 21:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:08 INFO - 'MOZ_NO_REMOTE': '1', 21:34:08 INFO - 'NO_EM_RESTART': '1', 21:34:08 INFO - 'PAGER': '/bin/cat', 21:34:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:08 INFO - 'PWD': '/builds/slave/test', 21:34:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:08 INFO - 'SHELL': '/bin/bash', 21:34:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6x1pHX8Ur/Listeners', 21:34:08 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 21:34:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:08 INFO - 'USER': 'cltbld', 21:34:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:08 INFO - 'XPC_FLAGS': '0x0', 21:34:08 INFO - 'XPC_SERVICE_NAME': '0', 21:34:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:08 INFO - Downloading/unpacking jsonschema 21:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:34:10 INFO - Downloading/unpacking functools32 (from jsonschema) 21:34:10 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 21:34:10 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 21:34:10 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 21:34:10 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 21:34:10 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 21:34:10 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 21:34:11 INFO - Downloading functools32-3.2.3-2.tar.gz 21:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:34:11 INFO - warning: no files found matching '*.txt' 21:34:11 INFO - no previously-included directories found matching 'build' 21:34:11 INFO - no previously-included directories found matching 'dist' 21:34:11 INFO - no previously-included directories found matching '.git*' 21:34:11 INFO - Installing collected packages: jsonschema, functools32 21:34:11 INFO - Running setup.py install for functools32 21:34:11 INFO - warning: no files found matching '*.txt' 21:34:11 INFO - no previously-included directories found matching 'build' 21:34:11 INFO - no previously-included directories found matching 'dist' 21:34:11 INFO - no previously-included directories found matching '.git*' 21:34:11 INFO - Successfully installed jsonschema functools32 21:34:11 INFO - Cleaning up... 21:34:11 INFO - Return code: 0 21:34:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:34:11 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')]} 21:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:11 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')]} 21:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:11 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 0x10847da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10848d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc02581750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10831ce00>, '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 0x108185db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108317b20>, '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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 21:34:11 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 21:34:11 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 21:34:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TxyN8nHzey/Render', 21:34:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:11 INFO - 'HOME': '/Users/cltbld', 21:34:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:11 INFO - 'LOGNAME': 'cltbld', 21:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:11 INFO - 'MOZ_NO_REMOTE': '1', 21:34:11 INFO - 'NO_EM_RESTART': '1', 21:34:11 INFO - 'PAGER': '/bin/cat', 21:34:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:11 INFO - 'PWD': '/builds/slave/test', 21:34:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:11 INFO - 'SHELL': '/bin/bash', 21:34:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6x1pHX8Ur/Listeners', 21:34:11 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 21:34:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:11 INFO - 'USER': 'cltbld', 21:34:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:11 INFO - 'XPC_FLAGS': '0x0', 21:34:11 INFO - 'XPC_SERVICE_NAME': '0', 21:34:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:11 INFO - Downloading/unpacking flake8 21:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:34:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:34:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:14 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 21:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:34:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:34:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:34:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:34:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:34:15 INFO - no previously-included directories found matching 'docs/_build' 21:34:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:34:15 INFO - Running setup.py install for pep8 21:34:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:34:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:34:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:34:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:34:15 INFO - no previously-included directories found matching 'docs/_build' 21:34:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:34:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:34:15 INFO - Cleaning up... 21:34:15 INFO - Return code: 0 21:34:15 INFO - Running post-action listener: _resource_record_post_action 21:34:15 INFO - Running post-action listener: _start_resource_monitoring 21:34:15 INFO - Starting resource monitoring. 21:34:15 INFO - ##### 21:34:15 INFO - ##### Running install step. 21:34:15 INFO - ##### 21:34:15 INFO - Running pre-action listener: _resource_record_pre_action 21:34:15 INFO - Running main action method: install 21:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:34:16 INFO - Reading from file tmpfile_stdout 21:34:16 INFO - Detecting whether we're running mozinstall >=1.0... 21:34:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:34:16 INFO - Reading from file tmpfile_stdout 21:34:16 INFO - Output received: 21:34:16 INFO - Usage: mozinstall [options] installer 21:34:16 INFO - Options: 21:34:16 INFO - -h, --help show this help message and exit 21:34:16 INFO - -d DEST, --destination=DEST 21:34:16 INFO - Directory to install application into. [default: 21:34:16 INFO - "/builds/slave/test"] 21:34:16 INFO - --app=APP Application being installed. [default: firefox] 21:34:16 INFO - mkdir: /builds/slave/test/build/application 21:34:16 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'] 21:34:16 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 21:34:37 INFO - Reading from file tmpfile_stdout 21:34:37 INFO - Output received: 21:34:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 21:34:37 INFO - Running post-action listener: _resource_record_post_action 21:34:37 INFO - ##### 21:34:37 INFO - ##### Running run-tests step. 21:34:37 INFO - ##### 21:34:37 INFO - Running pre-action listener: _resource_record_pre_action 21:34:37 INFO - Running main action method: run_tests 21:34:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:34:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:34:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:34:37 INFO - 2016-06-28 21:34:37.847 screenresolution[1642:8007] starting screenresolution argv=screenresolution get 21:34:37 INFO - 2016-06-28 21:34:37.849 screenresolution[1642:8007] Display 0: 1600x1200x32@60 21:34:37 INFO - 2016-06-28 21:34:37.855 screenresolution[1643:8009] starting screenresolution argv=screenresolution list 21:34:37 INFO - Available Modes on Display 0 21:34:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:34:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:34:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:34:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:34:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:34:38 INFO - Intel Iris: 21:34:38 INFO - Chipset Model: Intel Iris 21:34:38 INFO - Type: GPU 21:34:38 INFO - Bus: Built-In 21:34:38 INFO - VRAM (Dynamic, Max): 1536 MB 21:34:38 INFO - Vendor: Intel (0x8086) 21:34:38 INFO - Device ID: 0x0a2e 21:34:38 INFO - Revision ID: 0x0009 21:34:38 INFO - Displays: 21:34:38 INFO - Display: 21:34:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:34:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:34:38 INFO - Display Serial Number: 1600x1200 60 21:34:38 INFO - Main Display: Yes 21:34:38 INFO - Mirror: Off 21:34:38 INFO - Online: Yes 21:34:38 INFO - Rotation: Supported 21:34:38 INFO - Return code: 0 21:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:34:38 INFO - Python 2.7.3 21:34:38 INFO - Return code: 0 21:34:38 INFO - grabbing minidump binary from tooltool 21:34:38 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')]} 21:34:38 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 0x10831ce00>, '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 0x108185db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108317b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:34:38 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 21:34:38 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 21:34:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:34:38 INFO - Return code: 0 21:34:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:34:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:34:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:34:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:34:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:34:39 INFO - Return code: 0 21:34:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:34:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TxyN8nHzey/Render', 21:34:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:34:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:34:39 INFO - 'HOME': '/Users/cltbld', 21:34:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:34:39 INFO - 'LOGNAME': 'cltbld', 21:34:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:34:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:39 INFO - 'MOZ_NO_REMOTE': '1', 21:34:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:34:39 INFO - 'NO_EM_RESTART': '1', 21:34:39 INFO - 'PAGER': '/bin/cat', 21:34:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:39 INFO - 'PWD': '/builds/slave/test', 21:34:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:34:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:34:39 INFO - 'SHELL': '/bin/bash', 21:34:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6x1pHX8Ur/Listeners', 21:34:39 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 21:34:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:34:39 INFO - 'USER': 'cltbld', 21:34:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:34:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:39 INFO - 'XPC_FLAGS': '0x0', 21:34:39 INFO - 'XPC_SERVICE_NAME': '0', 21:34:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:34:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:34:39 INFO - mozversion application_buildid: 20160628145857 21:34:39 INFO - mozversion application_changeset: 2b22de79c849b6c915b01f0d306699261b2fdee3 21:34:39 INFO - mozversion application_display_name: Firefox 21:34:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:34:39 INFO - mozversion application_name: Firefox 21:34:39 INFO - mozversion application_remotingname: firefox 21:34:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:34:39 INFO - mozversion application_vendor: Mozilla 21:34:39 INFO - mozversion application_version: 48.0 21:34:39 INFO - mozversion platform_buildid: 20160628145857 21:34:39 INFO - mozversion platform_changeset: 2b22de79c849b6c915b01f0d306699261b2fdee3 21:34:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:34:39 INFO - mozversion platform_version: 48.0 21:34:39 INFO - using testdate: 1467174879 21:34:39 INFO - actual date: 1467174879 21:34:39 INFO - starting webserver on 'localhost:49269' 21:34:39 INFO - SUITE-START | Running 2 tests 21:34:39 INFO - TEST-START | dromaeo_css 21:34:39 INFO - operating with platform_type : mac_ 21:34:39 INFO - Initialising browser for dromaeo_css test... 21:34:39 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpSE7XDK/profile http://localhost:49269/getInfo.html) 21:34:41 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 21:34:41 INFO - PROCESS | 1661 | colorDepth:24 21:34:41 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 21:34:41 INFO - PROCESS | 1661 | __metrics 21:34:41 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:34:41 ERROR - PROCESS | 1661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:34:42 INFO - TEST-INFO | 1661: exit 0 21:34:42 INFO - Browser initialized. 21:34:42 INFO - Running cycle 1/1 for dromaeo_css test... 21:34:42 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpSE7XDK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:34:54 INFO - PROCESS | 1664 | RSS: Main: 161751040 21:34:54 INFO - PROCESS | 1664 | 21:35:45 INFO - PROCESS | 1664 | 1467174945493 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] 21:37:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 21:37:56 INFO - PROCESS | 1664 | RSS: Main: 321363968 21:37:56 INFO - PROCESS | 1664 | 21:40:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 21:41:00 INFO - PROCESS | 1664 | RSS: Main: 307298304 21:41:00 INFO - PROCESS | 1664 | 21:44:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 21:44:02 INFO - PROCESS | 1664 | RSS: Main: 310145024 21:44:02 INFO - PROCESS | 1664 | 21:47:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 21:47:05 INFO - PROCESS | 1664 | RSS: Main: 306323456 21:47:05 INFO - PROCESS | 1664 | 21:50:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 21:50:09 INFO - PROCESS | 1664 | RSS: Main: 272060416 21:50:09 INFO - PROCESS | 1664 | 21:53:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 21:53:12 INFO - PROCESS | 1664 | RSS: Main: 327839744 21:53:12 INFO - PROCESS | 1664 | 21:53:12 INFO - PROCESS | 1664 | __start_tp_report 21:53:12 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 21:53:12 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 21:53:12 INFO - PROCESS | 1664 | |i|pagename|runs| 21:53:12 INFO - PROCESS | 1664 | |0;dojo.html;3508.5965114011888;3537.4693795930607;3543.061088811464;3546.30846984838;3594.4248920172777;5820.097884827853;5836.15375770513;5839.678817665027;5851.268591426072;5882.147088672145;5823.126531020349;5870.735816888239;5876.647401155923;5886.705664716757;5907;5236.214567814839;5254.81608143715;5266.4733526647415;5346.27825243593;5377.139657654776;5183.326167598207;5312.787488500456;5315.468453154673;5342.385625653061;5349.866253343658;5294.100002999499;5329.120695085307;5330.040592693314;5353.5984801139875;5372.140457526796;5345.7594408251725;5362.865928351784;5370.570354371641;5388.191771234307;5401.70290634015;5155.793768249266;5233.528982391565;5270.57835373173;5289.391719952217;5293.206019097128;5653.660780353151;5698.34469036062;5704.172894930211;5741.598088133832;5756.856078598027;6277.686115694197;6284;6288.717007734663;6291.622502649856;6314.7474101035905;6210.285817131043;6235.282942461629;6300.30696623371;6313.621182729051;6318.589291696071;5907.852303692442;5927.585069045125;5955.880882382371;5975.611585246945;5993.4905533029305;6300.558960872695;6302.086197501337;6310.368963103745;6313.526485513605;6315.715792789336;6128.961487065875;6183.536234782409;6260.749570017239;6315.873682526416;6322.557420980487;6272;6295.898217811865;6301.653409062454;6307.5584709070845;6312.116303717483;6278.183836101369;6324.1778568786685;6332.778352757724;6347.777827776005;6356.396142366468;6216.7824126155365;6224.875502489925;6307.463865571478;6311.368863113652;6318;4979.651424400257;4989.3264409305;5005.7997680092385;5009;5040.991801639613;4528.728276303433;4538.614217791459;4544.0457503924545;4566.566176213254;4584;5797.449242321973;5868.149118377812;5929.991901376777;5964.582479226499;5982.102684597258;6201.224846894138;6231.4391704746795;6239.78160764371;6257.405546473078;6263.467605253604;5148.433672296044;5808.477237048686;5918.496927761103;5928.170056192136;5961.225040744762;5421.4578542146255;5472.98749731301;5491.588130890199;5496.1755736639025;5497.367802702661;6458.54790164684;6463.547551671432;6497.512686548528;6504.447121994589;6505.577137486048;6173.81478555644;6193.225846769154;6212.347703491249;6218.689065546795;6274.247090349188;6397.488200944006;6428.4214420702365;6433.260175079926;6454.548181627241;6478.319776423407;6315.905261421174;6321.11504389395;6324.683765811599;6331.335209803088;6343.714532846126;5457.508824205682;6170.568060235741;6204.627722336674;6257.311695713377;6287.968560157353;5495.807646732345;6193.4425901669065;6196.194494715838;6206.286277078194;6211.844703882439;6174.506039516918;6214.40963108504;6218.657973811484;6222.62664240147;6239.532035097295;5938.970305148447;6008.489278411384;6071.180390647206;6102.176206212104;6121.877562448815;6051.881811480103;6135.104208827337;6136.488442913377;6138.005148326901;6148.1085242640465;6020.51835853122;6044.304904935812;6055.424734650202;6069.575129740876;6077.301110372364 21:53:12 INFO - PROCESS | 1664 | |1;ext.html;545.6507834985607;558.2101326622827;582.0803131052937;584.5177728374092;600.3336296710653;33110.834445827764;33823.661763382355;40828.77513674587;41860.16279674412;42040.78979605105;44607.77696111523;44968.775156124175;45001;45081;45151.77424112883;8518.27594654455;9715.125638692534;9929.553170107363;9947.303688741791;9959.302848800588;9279.072092790735;12072.215306005126;12330.26018438892;12330.951869091137;12353.320567368792;12072.818907716392;12154.149209555335;12156.51373945041;12163.756724865498;12172.391380430987;11698.94709476147;11786.174967752218;11794.469248883821;11803.704907377298;11831;11950.641480755592;12055.035597152295;12062.215955962834;12065.819012714815;12067.637970860887;42392.36411453831;42807.785961069996;42842.78578607118;42846.57153428457;42848.57151428477;3331.716804071657;3364.2094107884627;3413.8634454621783;3469.5489586353865;3959.663428608572;29515;29524;29843.10470685883;30907.763689452397;31185.064448066594;2819;2835.8582070896373;2841.8863245470156;2918.460084884282;2935.192821973953;499122;500438;500840;501161.49419253034;501781;37774.24451511009;38407.42388864169;38450.230995380494;38452.42321365182;68679.65660171668;37416.50333986664;37502.87491375263;37656.623433765315;37687.05782355463;37800.62199378026;16464.753028704577;16573.751393729104;16595.751063734053;16608.92042017265;16611.41860034893;13086.738265234642;14001.85998140026;14088.15471071739;14363.92818035924;14549.85450145485;8493.235608795238;8505.404621676424;8555.786105347415;8579;8611.913880861111;3499.9650003500146;3538.6992105670793;3543.6102028776813;3550.609432962372;3591.676749092594;933.3140141995627;1060.6181774561153;1111.1888321525332;1159.756451145252;1185.5376403202758;30838;31302.686973129978;31372;31755.84122079421;31862.044138675876;825.9876101858476;1121.1871393239835;1220.9877901220875;1233.7100781316383;1342.4764341906664;13225.809677129104;14857.182854943081;15867.444639437565;16207.513774586545;16245.00399680251;659434;665924;667165.6641716857;667452;668810;65875.67062164658;66582.00126998099;66632.6668366655;66703.66648166729;66714.66642666755;1501.5495351394538;1516.780066890317;1577.6213708710056;1599.160440768606;1661.1279078483892;29981.100566983027;30633.846830765702;30833;31115.68884311128;31140.22149446282;51181.97636047184;51350;51730.96538069293;51755.741221293654;51821.48178518166;424859;431627;432336;432577;432682;25450;28865.134045978655;29247.268818279714;29608.259793505335;29638;43963;45078.87302817456;45219;45259;46850;37802.810985944896;38402.61597384102;38663.0334241635;38823.41764873473;38827.02932426712;37942;38314.233715326096;38338.42492362561;38811.417828732025;39069.8046509777;37542;38514.229715406094;39436.21127577375;39487.407688885265;39561.80219098886;33509;33571.49642755312;34360.65639343575;34470.65529344675;34753.13117172091;26104.8694756525;26164.73835261623;26236.8688156558;26444.471110578066;26752.33119172036 21:53:12 INFO - PROCESS | 1664 | |2;jquery.html;407.85113433596734;413.63393396843793;415.19037876141533;415.8981049642838;425.15818679015547;19870.60258794827;20955.47611309716;21752.456188595293;21760;21763.347099587038;21037.948102594884;21504.462388440297;22568;22585.54828903421;22604.43488912778;5555.777768889249;6130.233720784902;6131.448169664729;6146.8463288417925;6150.415710507517;5989.730462129215;6066.150738896558;6136.723847426876;6152.846178845542;6152.846178845542;5963.194968679216;6158.9692051539905;6162.476189523896;6164.1370208170665;6170.136180934673;5865.677387743673;6028.3067447243475;6122.877542449149;6123.510119190454;6140.232470941132;5388.676679399209;5421.0784166691365;5429.375621803464;5430.0768869292315;5435.42927992559;22256.332310030724;27582.5862612061;27785.444291114265;28279.293017674518;28317;2056.331692200026;2187.726534183227;2291.541691661674;2400.3159099656687;2914.562815577659;10142.340747851365;10187.592496300213;10267.332623379456;10361.89638103617;10686.19853510982;1771.1144427786107;1821.1349608935782;1824.5803465202946;1875.0812102069888;1883.7739471263399;120275.3986230072;126129.36935315357;128458;130212.99999999905;130324;9857.556409961426;12001.339926303963;12045.51817927273;12117.63647090571;12121.090918181171;15822.367105315889;15910.920445397698;15915.0450972942;15947.122908240159;15964.680706385807;8140.918590814016;8838.558072096497;9360.859587106199;9362.765930851783;9443.716688499357;9272.30457715674;9281.118293762082;9309.674161404453;9365.297602679826;9428.669996550088;4748.264019077049;4849.854504364875;4854.296127061627;4929.704217746947;4944.703317800871;1971.960560788776;1990.7611086669403;2050.5181282398626;2057.1360028787944;2082.6771850363216;941.709857495236;966.3766870368713;1002.6540843409012;1031.8194315994672;1035.140833108518;20805.063772130292;21377.144914203567;22040.669389959163;22201.777982220294;22446.32661020172;958.726762872578;1023.242800327767;1032.83990981398;1062.6227689170232;1073.656429942411;9956.701298961043;11149.665510034712;11312.660620181408;11943.641690749291;11988.100892432927;558260;564792;664732;678555;686820;95962;130944;135848.81320949306;140772.59227407596;149953;974.2254907348674;1000.4397537379091;1003.087190656499;1003.2010690174477;1034.8085604163405;19387;19903.60192796165;20079.799202007795;20093.899530502254;20179;32703.69185232564;32769.836150819094;52266.69333266699;54254.728726356116;56190;78417.60791196236;81586.59206703928;83035.5848220755;84095;86216.56891715502;8172.305354044973;8384.161583841811;8620.655173792979;8647.092055334351;8819.426737262058;12480.188787728768;12926.353682316034;13058.542950996669;13374.732505349644;13440.395182216627;11310.321380717183;11460.312381257152;11534.365609891536;11870.347130907538;11907.106966977684;6499.895017846883;11283.040941520063;11361.659150225507;11571.363575003455;11800.52797888075;11526.020288275591;11542.076633869103;11801.29192248468;11868.762624747284;11939.98510126649;8448;8464.238218560358;8479.36404769657;8568.742937711879;8594.31245500371;11063.336199828036;11543.249688770204;11614.361210133186;11788.587399440978;11946.581869634521 21:53:12 INFO - PROCESS | 1664 | |3;mootools.html;1450.0067453794145;1603.1743652019209;1641.7783599214106;1917.6835822089356;2040.02079002079;8319.667213311468;8874.334424918134;9054.502002389865;9096.636134554627;9130.452172869616;8721.694740684077;8950.86573701395;8984.550772461367;8989.550522473883;8995.775105622346;2521.457886554395;2543.338731929702;2543.631173479844;2546.6689330387117;2548.2227920484247;2508.1723031399683;2579.187555919889;2582.18661121747;2582.832115912469;2594.9740502595014;2547.605121206216;2566.781823545001;2591.818572699912;2596.7662910338067;2597.4025974025985;2536.5307418127613;2553.48930213957;2554.425254317782;2586.7025292091275;2587.14624174024;2528.4311030018284;2571.1643715792443;2571.1772232885482;2574.794016478696;2579.57437022891;8856.335774816851;9069.637214511411;9137.725868223964;9155.633774649006;9157.038510956387;5596.27248457702;5726.226959360475;5778.3643799182055;5792.044312688401;5794.304683437972;3373.375925453799;3436;3575.767575107636;3641.3627615167507;3700.1674623209833;1064.7444613292832;1068.0601071057497;1074.0280046557878;1079.4602698650674;1080.3032044331362;12244.632661020183;12357.93821030889;12552.497900083985;12578.55975040869;12582.24506529602;4240.173166232555;4771.451283102488;4822.469528351879;4834.927476087862;4897.240927656219;9660.661876834418;9749.561269742879;9766.560504777302;9786.510674466248;9809.852852207223;5533.6403133796175;5549.667019978814;5557.277553917965;5564.109742441271;5591.440855914376;4207.347861081476;4635.2120139576355;4791.592714619227;5147.459516750762;5180.7150606717;3909.237698648793;3993.800309984489;4026;4047.6559492442884;4052.0882801370044;1226.0620625221713;1230.3356187658565;1230.969225769345;1241.7081985733346;1243.5585367194697;961.4711908450324;972.5186032913753;978.2125389061731;992.0426788149471;1002.8646132772128;6112;6154.446099851035;6220.595661282002;6290.905636415458;6347.365263473615;467.7450789319829;477.0006835679246;486.2924444932614;487.8780304923769;491.87211325055745;4040.616141466556;4136;4154.813033413504;4170.812313445902;4224.91550169001;10838.512266948006;11359.432028398713;11362.204645674889;11367.147463940237;11395.601153959571;11053.17101217412;11174.329540227613;11178.161637877192;11192.880711928741;11213.775724485464;8559.101294364127;8671.523066231417;8679.609417576097;8682.522461264565;8741.475511469333;5776.393478684846;6078.300995385587;6097.908531372122;6113.694315284129;6127.479164271087;9668.661596844076;9893.01069893005;10026.197904167795;10039.69880903574;10048;9771.951140244253;10254.384736915808;10282.691519254435;10476.214283928583;10493.317934334244;7123.180834204133;7326.597037163007;7565.773026809205;7746.225377462209;7817.843643126992;7155.711971845118;8574.65701371963;8649.8702519461;8662.783430414038;8693.261072808882;6270.310265870842;7681;7681.61591920413;7818.530888146729;7873.1733168016535;7521.0974683038385;7579.166291707797;7584.051993500812;7699.576523291273;7730.652120654697;7261.745838895613;7300.96349518249;7317.414606831547;7333.303336183054;7335.193128755725;4961;5031.572316353151;5113.8721531962;5157.793688252428;5183.585313174862;5100.311457953278;5156.845294641167;5181.663191892515;5213.40045894727;5263.394709608444 21:53:12 INFO - PROCESS | 1664 | |4;prototype.html;325.42562377403874;331.3952037531505;341.6481024544719;343.6443281203954;343.9896803095908;6582.539222254432;6718.966405167974;6732.73069077237;6776.186857577085;6804.047433359334;5732.340780810208;6463.579867308622;6513.804585862432;6710.5302628816;6766.052752614638;5066.923996140052;5091.109055915219;5100.566451851579;5101.897962040757;5117.411497677759;4832.057748738997;4922.138625740499;4940.110780059588;5097.260897169908;5098.464661210575;4847.854564363075;4881.145799485093;4914.311996320518;4954.405471343443;4970.478099799505;4938.308636790852;4953.479884612136;4961.05739909416;4962.280469331963;4975.527324904128;4288.399624052635;4298.312270036779;4312.870613881589;4325.3728209409455;4331.891702707426;6415.871682566322;6424.903626445607;6433.453156481704;6434.453071488929;6441.162648855666;5526.557875370001;5780.1907732917425;5908.350081491032;5913.379095194986;5937.139114828326;7077.504574679774;7151.964240178818;7178.784636460915;7182.138143422822;7196.712131514733;4649.88375290617;4650.86047418578;4652.697574657636;4663.114008338405;4663.580277774982;7333.083364579427;7461.477696561188;7499.4000479962015;7609.847803043908;7619.504732192445;4693.272542755878;4741.786619602126;4743.525647435229;4748.240281554935;4751.144793937125;4215.409842622035;4827.961988172489;4831.275308703723;4836.419629644465;4836.685615435056;5771.797987070432;5773.595848290579;5775.191473193672;5796.797112101056;5800.129980502874;6571.835704107436;7233.31283528064;7268.781936541912;7271.127464704269;7271.127464704269;1591.2043978010995;1661.5762980440152;1664.1263336748061;1666.7166581681142;1667.9658611660604;984.9556769945369;990.1633120013577;1043.2853495355705;1064.834950582661;1064.920130990179;6546.509011824132;6559.376859198369;6636.270010298863;6640.667966601651;6648.13574235356;7450.292222238879;7451.727223196977;7464.402847772165;7466.290702383265;7466.925330746623;4789.3294938708605;6555.672216389162;6636.104125943032;6639.3692599203;6647.468202543785;3177.2374630089075;3854.5374555053572;3917.9020524487114;3938.0154961259686;3987.80060996949;7787.766367008999;7808.453408261481;7811.257930496594;7827.608619569112;7836.294733474015;7755.379569634416;7758.107817600935;7779.338756205672;7781.182975787574;7794;7865;7872.921270787448;7876.921230787619;7885.526868387915;7899.368050555941;7175.677094530863;7436.73971410998;7506.774796756106;7517.924820751722;7536.585487798224;5890.440408161217;7366.815829604088;7379.114506259283;7387.261273872785;7419.777406677808;7863.882041769263;7864.977552918084;7866.370690344873;7868.960655196687;7881.842363152819;4666.696664716783;4717.622590192707;4733.195356789285;4734.786934587883;4736.621070314435;5842.532597392284;7450.36671882896;7460;7469.850602987801;7498.475106742476;5896.616719913192;7174.461915356264;7199.2440793718;7224.494285399972;7251.492395532262;7212.098487689039;7246.275372462712;7262.31008054234;7263.636818159177;7274.818129546804;7079.82300442493;7091.290870912868;7093.432525398059;7101.254368291462;7128.215896251512;7022.578645281299;7197.280271972761;7214.062171917617;7231.4937954342695;7233.421326293989;5658.7736490541565;6728.663566821737;6965.407940325129;6983.650817459005;6993.125859267591 21:53:12 INFO - PROCESS | 1664 | |5;yui.html;761.4479502360789;774.4888373673369;781.531081351189;784.5136015670284;815.5351449673684;14521.20133392663;14527.854721452783;14782.408703651841;14799.999999999973;14844.480443184491;11975.401229938512;14425.206613636246;14667.119972801613;14667.633309167277;14671.706565868702;792.0574516325582;809.1988930958368;960.6877764726457;969.5346233807777;981.2983716642599;666.4268728893172;793.9087004994412;794.142326287608;950.6815216902312;978.9070038346346;1023.4319952426438;1024.7386916336325;1028.2185538990384;1028.9434081125535;1029.3720830293514;1017.6387382479187;1020.5662593397814;1021.0351218098899;1021.3310281765418;1023.6059117239841;609.6342194683199;735.1031741275635;765.1086484245847;774.4385320642546;776.1229810314309;14141.575752727333;14158.57524274263;14217.43130274798;14223.004389692725;14228;13070.86929130706;13097.934510327388;13274.800877986838;13434.193948363032;13772.586822395344;10028.849567256497;10156.035176658206;10218.386896786216;10318.277720559563;10447.738806529822;3641.526601541809;3648.4709717091137;3656.3601369760186;3708.332500149972;3772.1889793694486;63192;82084;83054.58472707658;88213;88649;9825.45959972194;9887.604495820231;9912.653057142965;9951;10380;23663;23665.171718989754;23675.526489470114;23682.88158559196;23718.881405592863;7787.571683557346;7893.013373328334;7905.881411778828;8025;8056.516609003362;4143.19207754485;4165.687573432005;4228.069824638575;4298.140371925628;4306.763128027988;3764.2095160016156;3778.7165962552917;3819.3698039823676;3824.8852534424013;3825.732198746061;646.9514786391039;649.357136434926;665.0987911380107;683.7555648719283;685.7771224352106;495.247224219192;533.9706316152572;601.2394321183706;613.8680183760513;617.5899123676625;8034.344373310129;8215.219554142346;8376.790580235422;8405.789855253544;8561.44350617208;590.9556783241275;595.6961949405834;606.8725567630759;609.2757496285501;619.7149311316845;3628.3650361186687;3745.4569087482164;3746.438034294823;3758.4362345647824;3793.3551296279147;97541.75811539828;99322.50338748404;99329;99403;100044.99955000503;82771.58614207011;83160.75258871121;83373;83607;85256;73056.99999999894;73352.63323683347;73633;74447;75544.62227688826;7430.7399241026305;7515.173330933483;7590.051243594551;7695.846083078419;7899.447038707235;50119.498805011484;50190.498095018585;50656.746716266185;51090.23364649459;52653;66619;71696.28303716896;71883.68697878144;72664.27335726575;73320.1669958234;9916.652917147865;9939.503024848584;10018.448985305879;10436.791264174522;10824.242303039027;10985.890141098806;11193.328400296008;11228.606998755004;11287.661370158909;11519.654410367702;9213.76965575866;10389.740256493647;10878.510467028844;10892.183086268404;11088.279261847954;10407.427591482541;11016.944915275373;11023.118150547776;11140.546430606539;11813.704657383634;11250.718732031764;11343.432828358715;11467.885321147016;11488.138389620644;11499.827502587636;9453.101955314234;9534.09426104519;9616.855747163938;9706.223502119954;10108.545115469675;9367.76049805304;9949;9950.303478756417;9980.251481139088;10002.24983126254 21:53:12 INFO - PROCESS | 1664 | __end_tp_report 21:53:12 INFO - PROCESS | 1664 | __start_cc_report 21:53:12 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1531 21:53:12 INFO - PROCESS | 1664 | __end_cc_report 21:53:12 INFO - PROCESS | 1664 | __startTimestamp1467175992000__endTimestamp 21:53:12 INFO - PROCESS | 1664 | 21:53:12 INFO - PROCESS | 1664 | ------- Summary: start ------- 21:53:12 INFO - PROCESS | 1664 | Number of tests: 6 21:53:12 INFO - PROCESS | 1664 | 21:53:12 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5832.59 Median:6055.42 stddev:620.98 (10.3%) stddev-sans-first:595.52 21:53:12 INFO - PROCESS | 1664 | Values: 3508.6 3537.5 3543.1 3546.3 3594.4 5820.1 5836.2 5839.7 5851.3 5882.1 5823.1 5870.7 5876.6 5886.7 5907.0 5236.2 5254.8 5266.5 5346.3 5377.1 5183.3 5312.8 5315.5 5342.4 5349.9 5294.1 5329.1 5330.0 5353.6 5372.1 5345.8 5362.9 5370.6 5388.2 5401.7 5155.8 5233.5 5270.6 5289.4 5293.2 5653.7 5698.3 5704.2 5741.6 5756.9 6277.7 6284.0 6288.7 6291.6 6314.7 6210.3 6235.3 6300.3 6313.6 6318.6 5907.9 5927.6 5955.9 5975.6 5993.5 6300.6 6302.1 6310.4 6313.5 6315.7 6129.0 6183.5 6260.7 6315.9 6322.6 6272.0 6295.9 6301.7 6307.6 6312.1 6278.2 6324.2 6332.8 6347.8 6356.4 6216.8 6224.9 6307.5 6311.4 6318.0 4979.7 4989.3 5005.8 5009.0 5041.0 4528.7 4538.6 4544.0 4566.6 4584.0 5797.4 5868.1 5930.0 5964.6 5982.1 6201.2 6231.4 6239.8 6257.4 6263.5 5148.4 5808.5 5918.5 5928.2 5961.2 5421.5 5473.0 5491.6 5496.2 5497.4 6458.5 6463.5 6497.5 6504.4 6505.6 6173.8 6193.2 6212.3 6218.7 6274.2 6397.5 6428.4 6433.3 6454.5 6478.3 6315.9 6321.1 6324.7 6331.3 6343.7 5457.5 6170.6 6204.6 6257.3 6288.0 5495.8 6193.4 6196.2 6206.3 6211.8 6174.5 6214.4 6218.7 6222.6 6239.5 5939.0 6008.5 6071.2 6102.2 6121.9 6051.9 6135.1 6136.5 6138.0 6148.1 6020.5 6044.3 6055.4 6069.6 6077.3 21:53:12 INFO - PROCESS | 1664 | 21:53:12 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:66441.06 Median:3547.11 stddev:144748.29 (4080.7%) stddev-sans-first:145069.79 21:53:12 INFO - PROCESS | 1664 | Values: 545.7 558.2 582.1 584.5 600.3 33110.8 33823.7 40828.8 41860.2 42040.8 44607.8 44968.8 45001.0 45081.0 45151.8 8518.3 9715.1 9929.6 9947.3 9959.3 9279.1 12072.2 12330.3 12331.0 12353.3 12072.8 12154.1 12156.5 12163.8 12172.4 11698.9 11786.2 11794.5 11803.7 11831.0 11950.6 12055.0 12062.2 12065.8 12067.6 42392.4 42807.8 42842.8 42846.6 42848.6 3331.7 3364.2 3413.9 3469.5 3959.7 29515.0 29524.0 29843.1 30907.8 31185.1 2819.0 2835.9 2841.9 2918.5 2935.2 499122.0 500438.0 500840.0 501161.5 501781.0 37774.2 38407.4 38450.2 38452.4 68679.7 37416.5 37502.9 37656.6 37687.1 37800.6 16464.8 16573.8 16595.8 16608.9 16611.4 13086.7 14001.9 14088.2 14363.9 14549.9 8493.2 8505.4 8555.8 8579.0 8611.9 3500.0 3538.7 3543.6 3550.6 3591.7 933.3 1060.6 1111.2 1159.8 1185.5 30838.0 31302.7 31372.0 31755.8 31862.0 826.0 1121.2 1221.0 1233.7 1342.5 13225.8 14857.2 15867.4 16207.5 16245.0 659434.0 665924.0 667165.7 667452.0 668810.0 65875.7 66582.0 66632.7 66703.7 66714.7 1501.5 1516.8 1577.6 1599.2 1661.1 29981.1 30633.8 30833.0 31115.7 31140.2 51182.0 51350.0 51731.0 51755.7 51821.5 424859.0 431627.0 432336.0 432577.0 432682.0 25450.0 28865.1 29247.3 29608.3 29638.0 43963.0 45078.9 45219.0 45259.0 46850.0 37802.8 38402.6 38663.0 38823.4 38827.0 37942.0 38314.2 38338.4 38811.4 39069.8 37542.0 38514.2 39436.2 39487.4 39561.8 33509.0 33571.5 34360.7 34470.7 34753.1 26104.9 26164.7 26236.9 26444.5 26752.3 21:53:12 INFO - PROCESS | 1664 | 21:53:12 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:36551.52 Median:22351.33 stddev:105682.47 (472.8%) stddev-sans-first:105944.09 21:53:12 INFO - PROCESS | 1664 | Values: 407.9 413.6 415.2 415.9 425.2 19870.6 20955.5 21752.5 21760.0 21763.3 21037.9 21504.5 22568.0 22585.5 22604.4 5555.8 6130.2 6131.4 6146.8 6150.4 5989.7 6066.2 6136.7 6152.8 6152.8 5963.2 6159.0 6162.5 6164.1 6170.1 5865.7 6028.3 6122.9 6123.5 6140.2 5388.7 5421.1 5429.4 5430.1 5435.4 22256.3 27582.6 27785.4 28279.3 28317.0 2056.3 2187.7 2291.5 2400.3 2914.6 10142.3 10187.6 10267.3 10361.9 10686.2 1771.1 1821.1 1824.6 1875.1 1883.8 120275.4 126129.4 128458.0 130213.0 130324.0 9857.6 12001.3 12045.5 12117.6 12121.1 15822.4 15910.9 15915.0 15947.1 15964.7 8140.9 8838.6 9360.9 9362.8 9443.7 9272.3 9281.1 9309.7 9365.3 9428.7 4748.3 4849.9 4854.3 4929.7 4944.7 1972.0 1990.8 2050.5 2057.1 2082.7 941.7 966.4 1002.7 1031.8 1035.1 20805.1 21377.1 22040.7 22201.8 22446.3 958.7 1023.2 1032.8 1062.6 1073.7 9956.7 11149.7 11312.7 11943.6 11988.1 558260.0 564792.0 664732.0 678555.0 686820.0 95962.0 130944.0 135848.8 140772.6 149953.0 974.2 1000.4 1003.1 1003.2 1034.8 19387.0 19903.6 20079.8 20093.9 20179.0 32703.7 32769.8 52266.7 54254.7 56190.0 78417.6 81586.6 83035.6 84095.0 86216.6 8172.3 8384.2 8620.7 8647.1 8819.4 12480.2 12926.4 13058.5 13374.7 13440.4 11310.3 11460.3 11534.4 11870.3 11907.1 6499.9 11283.0 11361.7 11571.4 11800.5 11526.0 11542.1 11801.3 11868.8 11940.0 8448.0 8464.2 8479.4 8568.7 8594.3 11063.3 11543.2 11614.4 11788.6 11946.6 21:53:12 INFO - PROCESS | 1664 | 21:53:12 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5889.40 Median:2726.44 stddev:3304.14 (121.2%) stddev-sans-first:3296.56 21:53:12 INFO - PROCESS | 1664 | Values: 1450.0 1603.2 1641.8 1917.7 2040.0 8319.7 8874.3 9054.5 9096.6 9130.5 8721.7 8950.9 8984.6 8989.6 8995.8 2521.5 2543.3 2543.6 2546.7 2548.2 2508.2 2579.2 2582.2 2582.8 2595.0 2547.6 2566.8 2591.8 2596.8 2597.4 2536.5 2553.5 2554.4 2586.7 2587.1 2528.4 2571.2 2571.2 2574.8 2579.6 8856.3 9069.6 9137.7 9155.6 9157.0 5596.3 5726.2 5778.4 5792.0 5794.3 3373.4 3436.0 3575.8 3641.4 3700.2 1064.7 1068.1 1074.0 1079.5 1080.3 12244.6 12357.9 12552.5 12578.6 12582.2 4240.2 4771.5 4822.5 4834.9 4897.2 9660.7 9749.6 9766.6 9786.5 9809.9 5533.6 5549.7 5557.3 5564.1 5591.4 4207.3 4635.2 4791.6 5147.5 5180.7 3909.2 3993.8 4026.0 4047.7 4052.1 1226.1 1230.3 1231.0 1241.7 1243.6 961.5 972.5 978.2 992.0 1002.9 6112.0 6154.4 6220.6 6290.9 6347.4 467.7 477.0 486.3 487.9 491.9 4040.6 4136.0 4154.8 4170.8 4224.9 10838.5 11359.4 11362.2 11367.1 11395.6 11053.2 11174.3 11178.2 11192.9 11213.8 8559.1 8671.5 8679.6 8682.5 8741.5 5776.4 6078.3 6097.9 6113.7 6127.5 9668.7 9893.0 10026.2 10039.7 10048.0 9772.0 10254.4 10282.7 10476.2 10493.3 7123.2 7326.6 7565.8 7746.2 7817.8 7155.7 8574.7 8649.9 8662.8 8693.3 6270.3 7681.0 7681.6 7818.5 7873.2 7521.1 7579.2 7584.1 7699.6 7730.7 7261.7 7301.0 7317.4 7333.3 7335.2 4961.0 5031.6 5113.9 5157.8 5183.6 5100.3 5156.8 5181.7 5213.4 5263.4 21:53:12 INFO - PROCESS | 1664 | 21:53:12 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5869.72 Median:6609.32 stddev:1890.71 (28.6%) stddev-sans-first:1849.65 21:53:12 INFO - PROCESS | 1664 | Values: 325.4 331.4 341.6 343.6 344.0 6582.5 6719.0 6732.7 6776.2 6804.0 5732.3 6463.6 6513.8 6710.5 6766.1 5066.9 5091.1 5100.6 5101.9 5117.4 4832.1 4922.1 4940.1 5097.3 5098.5 4847.9 4881.1 4914.3 4954.4 4970.5 4938.3 4953.5 4961.1 4962.3 4975.5 4288.4 4298.3 4312.9 4325.4 4331.9 6415.9 6424.9 6433.5 6434.5 6441.2 5526.6 5780.2 5908.4 5913.4 5937.1 7077.5 7152.0 7178.8 7182.1 7196.7 4649.9 4650.9 4652.7 4663.1 4663.6 7333.1 7461.5 7499.4 7609.8 7619.5 4693.3 4741.8 4743.5 4748.2 4751.1 4215.4 4828.0 4831.3 4836.4 4836.7 5771.8 5773.6 5775.2 5796.8 5800.1 6571.8 7233.3 7268.8 7271.1 7271.1 1591.2 1661.6 1664.1 1666.7 1668.0 985.0 990.2 1043.3 1064.8 1064.9 6546.5 6559.4 6636.3 6640.7 6648.1 7450.3 7451.7 7464.4 7466.3 7466.9 4789.3 6555.7 6636.1 6639.4 6647.5 3177.2 3854.5 3917.9 3938.0 3987.8 7787.8 7808.5 7811.3 7827.6 7836.3 7755.4 7758.1 7779.3 7781.2 7794.0 7865.0 7872.9 7876.9 7885.5 7899.4 7175.7 7436.7 7506.8 7517.9 7536.6 5890.4 7366.8 7379.1 7387.3 7419.8 7863.9 7865.0 7866.4 7869.0 7881.8 4666.7 4717.6 4733.2 4734.8 4736.6 5842.5 7450.4 7460.0 7469.9 7498.5 5896.6 7174.5 7199.2 7224.5 7251.5 7212.1 7246.3 7262.3 7263.6 7274.8 7079.8 7091.3 7093.4 7101.3 7128.2 7022.6 7197.3 7214.1 7231.5 7233.4 5658.8 6728.7 6965.4 6983.7 6993.1 21:53:12 INFO - PROCESS | 1664 | 21:53:12 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18907.07 Median:51871.62 stddev:27136.71 (52.3%) stddev-sans-first:27178.64 21:53:12 INFO - PROCESS | 1664 | Values: 761.4 774.5 781.5 784.5 815.5 14521.2 14527.9 14782.4 14800.0 14844.5 11975.4 14425.2 14667.1 14667.6 14671.7 792.1 809.2 960.7 969.5 981.3 666.4 793.9 794.1 950.7 978.9 1023.4 1024.7 1028.2 1028.9 1029.4 1017.6 1020.6 1021.0 1021.3 1023.6 609.6 735.1 765.1 774.4 776.1 14141.6 14158.6 14217.4 14223.0 14228.0 13070.9 13097.9 13274.8 13434.2 13772.6 10028.8 10156.0 10218.4 10318.3 10447.7 3641.5 3648.5 3656.4 3708.3 3772.2 63192.0 82084.0 83054.6 88213.0 88649.0 9825.5 9887.6 9912.7 9951.0 10380.0 23663.0 23665.2 23675.5 23682.9 23718.9 7787.6 7893.0 7905.9 8025.0 8056.5 4143.2 4165.7 4228.1 4298.1 4306.8 3764.2 3778.7 3819.4 3824.9 3825.7 647.0 649.4 665.1 683.8 685.8 495.2 534.0 601.2 613.9 617.6 8034.3 8215.2 8376.8 8405.8 8561.4 591.0 595.7 606.9 609.3 619.7 3628.4 3745.5 3746.4 3758.4 3793.4 97541.8 99322.5 99329.0 99403.0 100045.0 82771.6 83160.8 83373.0 83607.0 85256.0 73057.0 73352.6 73633.0 74447.0 75544.6 7430.7 7515.2 7590.1 7695.8 7899.4 50119.5 50190.5 50656.7 51090.2 52653.0 66619.0 71696.3 71883.7 72664.3 73320.2 9916.7 9939.5 10018.4 10436.8 10824.2 10985.9 11193.3 11228.6 11287.7 11519.7 9213.8 10389.7 10878.5 10892.2 11088.3 10407.4 11016.9 11023.1 11140.5 11813.7 11250.7 11343.4 11467.9 11488.1 11499.8 9453.1 9534.1 9616.9 9706.2 10108.5 9367.8 9949.0 9950.3 9980.3 10002.2 21:53:12 INFO - PROCESS | 1664 | -------- Summary: end -------- 21:53:12 INFO - PROCESS | 1664 | 21:53:12 INFO - TEST-INFO | 1664: exit 0 21:53:12 INFO - TEST-OK | dromaeo_css | took 1113053ms 21:53:12 INFO - TEST-START | kraken 21:53:12 INFO - operating with platform_type : mac_ 21:53:12 INFO - Initialising browser for kraken test... 21:53:12 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpfSq9ke/profile http://localhost:49269/getInfo.html) 21:53:14 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 21:53:14 INFO - PROCESS | 1671 | colorDepth:24 21:53:14 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 21:53:14 INFO - PROCESS | 1671 | __metrics 21:53:14 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:53:14 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:53:15 INFO - TEST-INFO | 1671: exit 0 21:53:15 INFO - Browser initialized. 21:53:15 INFO - Running cycle 1/1 for kraken test... 21:53:15 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpfSq9ke/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:53:27 INFO - PROCESS | 1674 | RSS: Main: 161980416 21:53:27 INFO - PROCESS | 1674 | 21:53:29 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 21:53:30 INFO - PROCESS | 1674 | RSS: Main: 223965184 21:53:30 INFO - PROCESS | 1674 | 21:53:33 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 21:53:33 INFO - PROCESS | 1674 | RSS: Main: 239964160 21:53:33 INFO - PROCESS | 1674 | 21:53:36 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 21:53:37 INFO - PROCESS | 1674 | RSS: Main: 325873664 21:53:37 INFO - PROCESS | 1674 | 21:53:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 21:53:40 INFO - PROCESS | 1674 | RSS: Main: 231018496 21:53:40 INFO - PROCESS | 1674 | 21:53:42 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:53:42 INFO - PROCESS | 1674 | RSS: Main: 231993344 21:53:42 INFO - PROCESS | 1674 | 21:53:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 21:53:46 INFO - PROCESS | 1674 | RSS: Main: 270356480 21:53:46 INFO - PROCESS | 1674 | 21:53:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 21:53:49 INFO - PROCESS | 1674 | RSS: Main: 271470592 21:53:49 INFO - PROCESS | 1674 | 21:53:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 21:53:52 INFO - PROCESS | 1674 | RSS: Main: 269533184 21:53:52 INFO - PROCESS | 1674 | 21:53:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:53:55 INFO - PROCESS | 1674 | RSS: Main: 260689920 21:53:55 INFO - PROCESS | 1674 | 21:53:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:53:57 INFO - PROCESS | 1674 | RSS: Main: 267153408 21:53:57 INFO - PROCESS | 1674 | 21:53:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:54:00 INFO - PROCESS | 1674 | RSS: Main: 271020032 21:54:00 INFO - PROCESS | 1674 | 21:54:03 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:54:03 INFO - PROCESS | 1674 | RSS: Main: 278118400 21:54:03 INFO - PROCESS | 1674 | 21:54:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:54:07 INFO - PROCESS | 1674 | RSS: Main: 275185664 21:54:07 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 21:54:09 INFO - PROCESS | 1674 | RSS: Main: 335900672 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | __start_tp_report 21:54:09 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 21:54:09 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 21:54:09 INFO - PROCESS | 1674 | |i|pagename|runs| 21:54:09 INFO - PROCESS | 1674 | |0;ai-astar;111;114;117;111;111;112;112;113;113;132 21:54:09 INFO - PROCESS | 1674 | |1;audio-beat-detection;156;123;141;162;117;138;118;149;154;113 21:54:09 INFO - PROCESS | 1674 | |2;audio-dft;183;185;188;185;186;182;186;186;183;183 21:54:09 INFO - PROCESS | 1674 | |3;audio-fft;67;77;74;147;56;56;56;63;143;82 21:54:09 INFO - PROCESS | 1674 | |4;audio-oscillator;92;91;147;80;78;81;122;79;77;125 21:54:09 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;89;85;89;87;87;85;89;85;88;85 21:54:09 INFO - PROCESS | 1674 | |6;imaging-darkroom;94;94;94;94;100;94;94;93;93;94 21:54:09 INFO - PROCESS | 1674 | |7;imaging-desaturate;85;84;83;83;83;83;85;84;83;86 21:54:09 INFO - PROCESS | 1674 | |8;json-parse-financial;58;61;65;61;61;64;62;79;57;56 21:54:09 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;61;63;65;110;106;92;66;66;82;89 21:54:09 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;91;102;102;78;79;78;77;77;80;82 21:54:09 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;127;124;125;137;135;124;125;151;160;128 21:54:09 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;163;161;160;157;163;154;166;161;157;159 21:54:09 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;64;63;67;66;65;65;68;86;94;95 21:54:09 INFO - PROCESS | 1674 | __end_tp_report 21:54:09 INFO - PROCESS | 1674 | __start_cc_report 21:54:09 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1876 21:54:09 INFO - PROCESS | 1674 | __end_cc_report 21:54:09 INFO - PROCESS | 1674 | __startTimestamp1467176049347__endTimestamp 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | ------- Summary: start ------- 21:54:09 INFO - PROCESS | 1674 | Number of tests: 14 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:114.60 Median:113.00 stddev:6.38 (5.6%) stddev-sans-first:6.63 21:54:09 INFO - PROCESS | 1674 | Values: 111.0 114.0 117.0 111.0 111.0 112.0 112.0 113.0 113.0 132.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:145.00 stddev:18.16 (12.5%) stddev-sans-first:17.93 21:54:09 INFO - PROCESS | 1674 | Values: 156.0 123.0 141.0 162.0 117.0 138.0 118.0 149.0 154.0 113.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.50 stddev:1.89 (1.0%) stddev-sans-first:1.90 21:54:09 INFO - PROCESS | 1674 | Values: 183.0 185.0 188.0 185.0 186.0 182.0 186.0 186.0 183.0 183.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:82.10 Median:65.00 stddev:34.40 (52.9%) stddev-sans-first:36.05 21:54:09 INFO - PROCESS | 1674 | Values: 67.0 77.0 74.0 147.0 56.0 56.0 56.0 63.0 143.0 82.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:79.50 stddev:24.94 (31.4%) stddev-sans-first:26.39 21:54:09 INFO - PROCESS | 1674 | Values: 92.0 91.0 147.0 80.0 78.0 81.0 122.0 79.0 77.0 125.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:87.50 stddev:1.79 (2.0%) stddev-sans-first:1.73 21:54:09 INFO - PROCESS | 1674 | Values: 89.0 85.0 89.0 87.0 87.0 85.0 89.0 85.0 88.0 85.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.00 stddev:2.01 (2.1%) stddev-sans-first:2.13 21:54:09 INFO - PROCESS | 1674 | Values: 94.0 94.0 94.0 94.0 100.0 94.0 94.0 93.0 93.0 94.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:1.10 (1.3%) stddev-sans-first:1.09 21:54:09 INFO - PROCESS | 1674 | Values: 85.0 84.0 83.0 83.0 83.0 83.0 85.0 84.0 83.0 86.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:61.50 stddev:6.50 (10.6%) stddev-sans-first:6.70 21:54:09 INFO - PROCESS | 1674 | Values: 58.0 61.0 65.0 61.0 61.0 64.0 62.0 79.0 57.0 56.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:66.00 stddev:18.48 (28.0%) stddev-sans-first:18.27 21:54:09 INFO - PROCESS | 1674 | Values: 61.0 63.0 65.0 110.0 106.0 92.0 66.0 66.0 82.0 89.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:78.50 stddev:10.05 (12.8%) stddev-sans-first:10.39 21:54:09 INFO - PROCESS | 1674 | Values: 91.0 102.0 102.0 78.0 79.0 78.0 77.0 77.0 80.0 82.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:131.50 stddev:12.56 (9.6%) stddev-sans-first:13.10 21:54:09 INFO - PROCESS | 1674 | Values: 127.0 124.0 125.0 137.0 135.0 124.0 125.0 151.0 160.0 128.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:161.00 stddev:3.51 (2.2%) stddev-sans-first:3.56 21:54:09 INFO - PROCESS | 1674 | Values: 163.0 161.0 160.0 157.0 163.0 154.0 166.0 161.0 157.0 159.0 21:54:09 INFO - PROCESS | 1674 | 21:54:09 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:67.50 stddev:12.96 (19.2%) stddev-sans-first:13.30 21:54:09 INFO - PROCESS | 1674 | Values: 64.0 63.0 67.0 66.0 65.0 65.0 68.0 86.0 94.0 95.0 21:54:09 INFO - PROCESS | 1674 | -------- Summary: end -------- 21:54:09 INFO - PROCESS | 1674 | 21:54:10 INFO - TEST-INFO | 1674: exit 0 21:54:10 INFO - TEST-OK | kraken | took 57587ms 21:54:10 INFO - SUITE-END | took 1170s 21:54:10 INFO - Completed test suite (00:19:30) 21:54:10 INFO - javascript benchmark 21:54:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3508.5965114011888, 3537.4693795930607, 3543.061088811464, 3546.30846984838, 3594.4248920172777, 5820.097884827853, 5836.15375770513, 5839.678817665027, 5851.268591426072, 5882.147088672145, 5823.126531020349, 5870.735816888239, 5876.647401155923, 5886.705664716757, 5907.0, 5236.214567814839, 5254.81608143715, 5266.4733526647415, 5346.27825243593, 5377.139657654776, 5183.326167598207, 5312.787488500456, 5315.468453154673, 5342.385625653061, 5349.866253343658, 5294.100002999499, 5329.120695085307, 5330.040592693314, 5353.5984801139875, 5372.140457526796, 5345.7594408251725, 5362.865928351784, 5370.570354371641, 5388.191771234307, 5401.70290634015, 5155.793768249266, 5233.528982391565, 5270.57835373173, 5289.391719952217, 5293.206019097128, 5653.660780353151, 5698.34469036062, 5704.172894930211, 5741.598088133832, 5756.856078598027, 6277.686115694197, 6284.0, 6288.717007734663, 6291.622502649856, 6314.7474101035905, 6210.285817131043, 6235.282942461629, 6300.30696623371, 6313.621182729051, 6318.589291696071, 5907.852303692442, 5927.585069045125, 5955.880882382371, 5975.611585246945, 5993.4905533029305, 6300.558960872695, 6302.086197501337, 6310.368963103745, 6313.526485513605, 6315.715792789336, 6128.961487065875, 6183.536234782409, 6260.749570017239, 6315.873682526416, 6322.557420980487, 6272.0, 6295.898217811865, 6301.653409062454, 6307.5584709070845, 6312.116303717483, 6278.183836101369, 6324.1778568786685, 6332.778352757724, 6347.777827776005, 6356.396142366468, 6216.7824126155365, 6224.875502489925, 6307.463865571478, 6311.368863113652, 6318.0, 4979.651424400257, 4989.3264409305, 5005.7997680092385, 5009.0, 5040.991801639613, 4528.728276303433, 4538.614217791459, 4544.0457503924545, 4566.566176213254, 4584.0, 5797.449242321973, 5868.149118377812, 5929.991901376777, 5964.582479226499, 5982.102684597258, 6201.224846894138, 6231.4391704746795, 6239.78160764371, 6257.405546473078, 6263.467605253604, 5148.433672296044, 5808.477237048686, 5918.496927761103, 5928.170056192136, 5961.225040744762, 5421.4578542146255, 5472.98749731301, 5491.588130890199, 5496.1755736639025, 5497.367802702661, 6458.54790164684, 6463.547551671432, 6497.512686548528, 6504.447121994589, 6505.577137486048, 6173.81478555644, 6193.225846769154, 6212.347703491249, 6218.689065546795, 6274.247090349188, 6397.488200944006, 6428.4214420702365, 6433.260175079926, 6454.548181627241, 6478.319776423407, 6315.905261421174, 6321.11504389395, 6324.683765811599, 6331.335209803088, 6343.714532846126, 5457.508824205682, 6170.568060235741, 6204.627722336674, 6257.311695713377, 6287.968560157353, 5495.807646732345, 6193.4425901669065, 6196.194494715838, 6206.286277078194, 6211.844703882439, 6174.506039516918, 6214.40963108504, 6218.657973811484, 6222.62664240147, 6239.532035097295, 5938.970305148447, 6008.489278411384, 6071.180390647206, 6102.176206212104, 6121.877562448815, 6051.881811480103, 6135.104208827337, 6136.488442913377, 6138.005148326901, 6148.1085242640465, 6020.51835853122, 6044.304904935812, 6055.424734650202, 6069.575129740876, 6077.301110372364], "value": 5794.844008599126, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.6507834985607, 558.2101326622827, 582.0803131052937, 584.5177728374092, 600.3336296710653, 33110.834445827764, 33823.661763382355, 40828.77513674587, 41860.16279674412, 42040.78979605105, 44607.77696111523, 44968.775156124175, 45001.0, 45081.0, 45151.77424112883, 8518.27594654455, 9715.125638692534, 9929.553170107363, 9947.303688741791, 9959.302848800588, 9279.072092790735, 12072.215306005126, 12330.26018438892, 12330.951869091137, 12353.320567368792, 12072.818907716392, 12154.149209555335, 12156.51373945041, 12163.756724865498, 12172.391380430987, 11698.94709476147, 11786.174967752218, 11794.469248883821, 11803.704907377298, 11831.0, 11950.641480755592, 12055.035597152295, 12062.215955962834, 12065.819012714815, 12067.637970860887, 42392.36411453831, 42807.785961069996, 42842.78578607118, 42846.57153428457, 42848.57151428477, 3331.716804071657, 3364.2094107884627, 3413.8634454621783, 3469.5489586353865, 3959.663428608572, 29515.0, 29524.0, 29843.10470685883, 30907.763689452397, 31185.064448066594, 2819.0, 2835.8582070896373, 2841.8863245470156, 2918.460084884282, 2935.192821973953, 499122.0, 500438.0, 500840.0, 501161.49419253034, 501781.0, 37774.24451511009, 38407.42388864169, 38450.230995380494, 38452.42321365182, 68679.65660171668, 37416.50333986664, 37502.87491375263, 37656.623433765315, 37687.05782355463, 37800.62199378026, 16464.753028704577, 16573.751393729104, 16595.751063734053, 16608.92042017265, 16611.41860034893, 13086.738265234642, 14001.85998140026, 14088.15471071739, 14363.92818035924, 14549.85450145485, 8493.235608795238, 8505.404621676424, 8555.786105347415, 8579.0, 8611.913880861111, 3499.9650003500146, 3538.6992105670793, 3543.6102028776813, 3550.609432962372, 3591.676749092594, 933.3140141995627, 1060.6181774561153, 1111.1888321525332, 1159.756451145252, 1185.5376403202758, 30838.0, 31302.686973129978, 31372.0, 31755.84122079421, 31862.044138675876, 825.9876101858476, 1121.1871393239835, 1220.9877901220875, 1233.7100781316383, 1342.4764341906664, 13225.809677129104, 14857.182854943081, 15867.444639437565, 16207.513774586545, 16245.00399680251, 659434.0, 665924.0, 667165.6641716857, 667452.0, 668810.0, 65875.67062164658, 66582.00126998099, 66632.6668366655, 66703.66648166729, 66714.66642666755, 1501.5495351394538, 1516.780066890317, 1577.6213708710056, 1599.160440768606, 1661.1279078483892, 29981.100566983027, 30633.846830765702, 30833.0, 31115.68884311128, 31140.22149446282, 51181.97636047184, 51350.0, 51730.96538069293, 51755.741221293654, 51821.48178518166, 424859.0, 431627.0, 432336.0, 432577.0, 432682.0, 25450.0, 28865.134045978655, 29247.268818279714, 29608.259793505335, 29638.0, 43963.0, 45078.87302817456, 45219.0, 45259.0, 46850.0, 37802.810985944896, 38402.61597384102, 38663.0334241635, 38823.41764873473, 38827.02932426712, 37942.0, 38314.233715326096, 38338.42492362561, 38811.417828732025, 39069.8046509777, 37542.0, 38514.229715406094, 39436.21127577375, 39487.407688885265, 39561.80219098886, 33509.0, 33571.49642755312, 34360.65639343575, 34470.65529344675, 34753.13117172091, 26104.8694756525, 26164.73835261623, 26236.8688156558, 26444.471110578066, 26752.33119172036], "value": 19509.905700864663, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.85113433596734, 413.63393396843793, 415.19037876141533, 415.8981049642838, 425.15818679015547, 19870.60258794827, 20955.47611309716, 21752.456188595293, 21760.0, 21763.347099587038, 21037.948102594884, 21504.462388440297, 22568.0, 22585.54828903421, 22604.43488912778, 5555.777768889249, 6130.233720784902, 6131.448169664729, 6146.8463288417925, 6150.415710507517, 5989.730462129215, 6066.150738896558, 6136.723847426876, 6152.846178845542, 6152.846178845542, 5963.194968679216, 6158.9692051539905, 6162.476189523896, 6164.1370208170665, 6170.136180934673, 5865.677387743673, 6028.3067447243475, 6122.877542449149, 6123.510119190454, 6140.232470941132, 5388.676679399209, 5421.0784166691365, 5429.375621803464, 5430.0768869292315, 5435.42927992559, 22256.332310030724, 27582.5862612061, 27785.444291114265, 28279.293017674518, 28317.0, 2056.331692200026, 2187.726534183227, 2291.541691661674, 2400.3159099656687, 2914.562815577659, 10142.340747851365, 10187.592496300213, 10267.332623379456, 10361.89638103617, 10686.19853510982, 1771.1144427786107, 1821.1349608935782, 1824.5803465202946, 1875.0812102069888, 1883.7739471263399, 120275.3986230072, 126129.36935315357, 128458.0, 130212.99999999905, 130324.0, 9857.556409961426, 12001.339926303963, 12045.51817927273, 12117.63647090571, 12121.090918181171, 15822.367105315889, 15910.920445397698, 15915.0450972942, 15947.122908240159, 15964.680706385807, 8140.918590814016, 8838.558072096497, 9360.859587106199, 9362.765930851783, 9443.716688499357, 9272.30457715674, 9281.118293762082, 9309.674161404453, 9365.297602679826, 9428.669996550088, 4748.264019077049, 4849.854504364875, 4854.296127061627, 4929.704217746947, 4944.703317800871, 1971.960560788776, 1990.7611086669403, 2050.5181282398626, 2057.1360028787944, 2082.6771850363216, 941.709857495236, 966.3766870368713, 1002.6540843409012, 1031.8194315994672, 1035.140833108518, 20805.063772130292, 21377.144914203567, 22040.669389959163, 22201.777982220294, 22446.32661020172, 958.726762872578, 1023.242800327767, 1032.83990981398, 1062.6227689170232, 1073.656429942411, 9956.701298961043, 11149.665510034712, 11312.660620181408, 11943.641690749291, 11988.100892432927, 558260.0, 564792.0, 664732.0, 678555.0, 686820.0, 95962.0, 130944.0, 135848.81320949306, 140772.59227407596, 149953.0, 974.2254907348674, 1000.4397537379091, 1003.087190656499, 1003.2010690174477, 1034.8085604163405, 19387.0, 19903.60192796165, 20079.799202007795, 20093.899530502254, 20179.0, 32703.69185232564, 32769.836150819094, 52266.69333266699, 54254.728726356116, 56190.0, 78417.60791196236, 81586.59206703928, 83035.5848220755, 84095.0, 86216.56891715502, 8172.305354044973, 8384.161583841811, 8620.655173792979, 8647.092055334351, 8819.426737262058, 12480.188787728768, 12926.353682316034, 13058.542950996669, 13374.732505349644, 13440.395182216627, 11310.321380717183, 11460.312381257152, 11534.365609891536, 11870.347130907538, 11907.106966977684, 6499.895017846883, 11283.040941520063, 11361.659150225507, 11571.363575003455, 11800.52797888075, 11526.020288275591, 11542.076633869103, 11801.29192248468, 11868.762624747284, 11939.98510126649, 8448.0, 8464.238218560358, 8479.36404769657, 8568.742937711879, 8594.31245500371, 11063.336199828036, 11543.249688770204, 11614.361210133186, 11788.587399440978, 11946.581869634521], "value": 9951.52291721462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.0067453794145, 1603.1743652019209, 1641.7783599214106, 1917.6835822089356, 2040.02079002079, 8319.667213311468, 8874.334424918134, 9054.502002389865, 9096.636134554627, 9130.452172869616, 8721.694740684077, 8950.86573701395, 8984.550772461367, 8989.550522473883, 8995.775105622346, 2521.457886554395, 2543.338731929702, 2543.631173479844, 2546.6689330387117, 2548.2227920484247, 2508.1723031399683, 2579.187555919889, 2582.18661121747, 2582.832115912469, 2594.9740502595014, 2547.605121206216, 2566.781823545001, 2591.818572699912, 2596.7662910338067, 2597.4025974025985, 2536.5307418127613, 2553.48930213957, 2554.425254317782, 2586.7025292091275, 2587.14624174024, 2528.4311030018284, 2571.1643715792443, 2571.1772232885482, 2574.794016478696, 2579.57437022891, 8856.335774816851, 9069.637214511411, 9137.725868223964, 9155.633774649006, 9157.038510956387, 5596.27248457702, 5726.226959360475, 5778.3643799182055, 5792.044312688401, 5794.304683437972, 3373.375925453799, 3436.0, 3575.767575107636, 3641.3627615167507, 3700.1674623209833, 1064.7444613292832, 1068.0601071057497, 1074.0280046557878, 1079.4602698650674, 1080.3032044331362, 12244.632661020183, 12357.93821030889, 12552.497900083985, 12578.55975040869, 12582.24506529602, 4240.173166232555, 4771.451283102488, 4822.469528351879, 4834.927476087862, 4897.240927656219, 9660.661876834418, 9749.561269742879, 9766.560504777302, 9786.510674466248, 9809.852852207223, 5533.6403133796175, 5549.667019978814, 5557.277553917965, 5564.109742441271, 5591.440855914376, 4207.347861081476, 4635.2120139576355, 4791.592714619227, 5147.459516750762, 5180.7150606717, 3909.237698648793, 3993.800309984489, 4026.0, 4047.6559492442884, 4052.0882801370044, 1226.0620625221713, 1230.3356187658565, 1230.969225769345, 1241.7081985733346, 1243.5585367194697, 961.4711908450324, 972.5186032913753, 978.2125389061731, 992.0426788149471, 1002.8646132772128, 6112.0, 6154.446099851035, 6220.595661282002, 6290.905636415458, 6347.365263473615, 467.7450789319829, 477.0006835679246, 486.2924444932614, 487.8780304923769, 491.87211325055745, 4040.616141466556, 4136.0, 4154.813033413504, 4170.812313445902, 4224.91550169001, 10838.512266948006, 11359.432028398713, 11362.204645674889, 11367.147463940237, 11395.601153959571, 11053.17101217412, 11174.329540227613, 11178.161637877192, 11192.880711928741, 11213.775724485464, 8559.101294364127, 8671.523066231417, 8679.609417576097, 8682.522461264565, 8741.475511469333, 5776.393478684846, 6078.300995385587, 6097.908531372122, 6113.694315284129, 6127.479164271087, 9668.661596844076, 9893.01069893005, 10026.197904167795, 10039.69880903574, 10048.0, 9771.951140244253, 10254.384736915808, 10282.691519254435, 10476.214283928583, 10493.317934334244, 7123.180834204133, 7326.597037163007, 7565.773026809205, 7746.225377462209, 7817.843643126992, 7155.711971845118, 8574.65701371963, 8649.8702519461, 8662.783430414038, 8693.261072808882, 6270.310265870842, 7681.0, 7681.61591920413, 7818.530888146729, 7873.1733168016535, 7521.0974683038385, 7579.166291707797, 7584.051993500812, 7699.576523291273, 7730.652120654697, 7261.745838895613, 7300.96349518249, 7317.414606831547, 7333.303336183054, 7335.193128755725, 4961.0, 5031.572316353151, 5113.8721531962, 5157.793688252428, 5183.585313174862, 5100.311457953278, 5156.845294641167, 5181.663191892515, 5213.40045894727, 5263.394709608444], "value": 4674.346055120926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.42562377403874, 331.3952037531505, 341.6481024544719, 343.6443281203954, 343.9896803095908, 6582.539222254432, 6718.966405167974, 6732.73069077237, 6776.186857577085, 6804.047433359334, 5732.340780810208, 6463.579867308622, 6513.804585862432, 6710.5302628816, 6766.052752614638, 5066.923996140052, 5091.109055915219, 5100.566451851579, 5101.897962040757, 5117.411497677759, 4832.057748738997, 4922.138625740499, 4940.110780059588, 5097.260897169908, 5098.464661210575, 4847.854564363075, 4881.145799485093, 4914.311996320518, 4954.405471343443, 4970.478099799505, 4938.308636790852, 4953.479884612136, 4961.05739909416, 4962.280469331963, 4975.527324904128, 4288.399624052635, 4298.312270036779, 4312.870613881589, 4325.3728209409455, 4331.891702707426, 6415.871682566322, 6424.903626445607, 6433.453156481704, 6434.453071488929, 6441.162648855666, 5526.557875370001, 5780.1907732917425, 5908.350081491032, 5913.379095194986, 5937.139114828326, 7077.504574679774, 7151.964240178818, 7178.784636460915, 7182.138143422822, 7196.712131514733, 4649.88375290617, 4650.86047418578, 4652.697574657636, 4663.114008338405, 4663.580277774982, 7333.083364579427, 7461.477696561188, 7499.4000479962015, 7609.847803043908, 7619.504732192445, 4693.272542755878, 4741.786619602126, 4743.525647435229, 4748.240281554935, 4751.144793937125, 4215.409842622035, 4827.961988172489, 4831.275308703723, 4836.419629644465, 4836.685615435056, 5771.797987070432, 5773.595848290579, 5775.191473193672, 5796.797112101056, 5800.129980502874, 6571.835704107436, 7233.31283528064, 7268.781936541912, 7271.127464704269, 7271.127464704269, 1591.2043978010995, 1661.5762980440152, 1664.1263336748061, 1666.7166581681142, 1667.9658611660604, 984.9556769945369, 990.1633120013577, 1043.2853495355705, 1064.834950582661, 1064.920130990179, 6546.509011824132, 6559.376859198369, 6636.270010298863, 6640.667966601651, 6648.13574235356, 7450.292222238879, 7451.727223196977, 7464.402847772165, 7466.290702383265, 7466.925330746623, 4789.3294938708605, 6555.672216389162, 6636.104125943032, 6639.3692599203, 6647.468202543785, 3177.2374630089075, 3854.5374555053572, 3917.9020524487114, 3938.0154961259686, 3987.80060996949, 7787.766367008999, 7808.453408261481, 7811.257930496594, 7827.608619569112, 7836.294733474015, 7755.379569634416, 7758.107817600935, 7779.338756205672, 7781.182975787574, 7794.0, 7865.0, 7872.921270787448, 7876.921230787619, 7885.526868387915, 7899.368050555941, 7175.677094530863, 7436.73971410998, 7506.774796756106, 7517.924820751722, 7536.585487798224, 5890.440408161217, 7366.815829604088, 7379.114506259283, 7387.261273872785, 7419.777406677808, 7863.882041769263, 7864.977552918084, 7866.370690344873, 7868.960655196687, 7881.842363152819, 4666.696664716783, 4717.622590192707, 4733.195356789285, 4734.786934587883, 4736.621070314435, 5842.532597392284, 7450.36671882896, 7460.0, 7469.850602987801, 7498.475106742476, 5896.616719913192, 7174.461915356264, 7199.2440793718, 7224.494285399972, 7251.492395532262, 7212.098487689039, 7246.275372462712, 7262.31008054234, 7263.636818159177, 7274.818129546804, 7079.82300442493, 7091.290870912868, 7093.432525398059, 7101.254368291462, 7128.215896251512, 7022.578645281299, 7197.280271972761, 7214.062171917617, 7231.4937954342695, 7233.421326293989, 5658.7736490541565, 6728.663566821737, 6965.407940325129, 6983.650817459005, 6993.125859267591], "value": 5234.691207601641, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.4479502360789, 774.4888373673369, 781.531081351189, 784.5136015670284, 815.5351449673684, 14521.20133392663, 14527.854721452783, 14782.408703651841, 14799.999999999973, 14844.480443184491, 11975.401229938512, 14425.206613636246, 14667.119972801613, 14667.633309167277, 14671.706565868702, 792.0574516325582, 809.1988930958368, 960.6877764726457, 969.5346233807777, 981.2983716642599, 666.4268728893172, 793.9087004994412, 794.142326287608, 950.6815216902312, 978.9070038346346, 1023.4319952426438, 1024.7386916336325, 1028.2185538990384, 1028.9434081125535, 1029.3720830293514, 1017.6387382479187, 1020.5662593397814, 1021.0351218098899, 1021.3310281765418, 1023.6059117239841, 609.6342194683199, 735.1031741275635, 765.1086484245847, 774.4385320642546, 776.1229810314309, 14141.575752727333, 14158.57524274263, 14217.43130274798, 14223.004389692725, 14228.0, 13070.86929130706, 13097.934510327388, 13274.800877986838, 13434.193948363032, 13772.586822395344, 10028.849567256497, 10156.035176658206, 10218.386896786216, 10318.277720559563, 10447.738806529822, 3641.526601541809, 3648.4709717091137, 3656.3601369760186, 3708.332500149972, 3772.1889793694486, 63192.0, 82084.0, 83054.58472707658, 88213.0, 88649.0, 9825.45959972194, 9887.604495820231, 9912.653057142965, 9951.0, 10380.0, 23663.0, 23665.171718989754, 23675.526489470114, 23682.88158559196, 23718.881405592863, 7787.571683557346, 7893.013373328334, 7905.881411778828, 8025.0, 8056.516609003362, 4143.19207754485, 4165.687573432005, 4228.069824638575, 4298.140371925628, 4306.763128027988, 3764.2095160016156, 3778.7165962552917, 3819.3698039823676, 3824.8852534424013, 3825.732198746061, 646.9514786391039, 649.357136434926, 665.0987911380107, 683.7555648719283, 685.7771224352106, 495.247224219192, 533.9706316152572, 601.2394321183706, 613.8680183760513, 617.5899123676625, 8034.344373310129, 8215.219554142346, 8376.790580235422, 8405.789855253544, 8561.44350617208, 590.9556783241275, 595.6961949405834, 606.8725567630759, 609.2757496285501, 619.7149311316845, 3628.3650361186687, 3745.4569087482164, 3746.438034294823, 3758.4362345647824, 3793.3551296279147, 97541.75811539828, 99322.50338748404, 99329.0, 99403.0, 100044.99955000503, 82771.58614207011, 83160.75258871121, 83373.0, 83607.0, 85256.0, 73056.99999999894, 73352.63323683347, 73633.0, 74447.0, 75544.62227688826, 7430.7399241026305, 7515.173330933483, 7590.051243594551, 7695.846083078419, 7899.447038707235, 50119.498805011484, 50190.498095018585, 50656.746716266185, 51090.23364649459, 52653.0, 66619.0, 71696.28303716896, 71883.68697878144, 72664.27335726575, 73320.1669958234, 9916.652917147865, 9939.503024848584, 10018.448985305879, 10436.791264174522, 10824.242303039027, 10985.890141098806, 11193.328400296008, 11228.606998755004, 11287.661370158909, 11519.654410367702, 9213.76965575866, 10389.740256493647, 10878.510467028844, 10892.183086268404, 11088.279261847954, 10407.427591482541, 11016.944915275373, 11023.118150547776, 11140.546430606539, 11813.704657383634, 11250.718732031764, 11343.432828358715, 11467.885321147016, 11488.138389620644, 11499.827502587636, 9453.101955314234, 9534.09426104519, 9616.855747163938, 9706.223502119954, 10108.545115469675, 9367.76049805304, 9949.0, 9950.303478756417, 9980.251481139088, 10002.24983126254], "value": 7019.3591489812325, "unit": "score"}], "name": "dromaeo_css", "value": 7603.647189645471, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 117.0, 111.0, 111.0, 112.0, 112.0, 113.0, 113.0, 132.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 141.0, 162.0, 117.0, 138.0, 118.0, 149.0, 154.0, 113.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 188.0, 185.0, 186.0, 182.0, 186.0, 186.0, 183.0, 183.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 77.0, 74.0, 147.0, 56.0, 56.0, 56.0, 63.0, 143.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 147.0, 80.0, 78.0, 81.0, 122.0, 79.0, 77.0, 125.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 87.0, 87.0, 85.0, 89.0, 85.0, 88.0, 85.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 100.0, 94.0, 94.0, 93.0, 93.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 83.0, 83.0, 83.0, 85.0, 84.0, 83.0, 86.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 65.0, 61.0, 61.0, 64.0, 62.0, 79.0, 57.0, 56.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 65.0, 110.0, 106.0, 92.0, 66.0, 66.0, 82.0, 89.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 102.0, 102.0, 78.0, 79.0, 78.0, 77.0, 77.0, 80.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 125.0, 137.0, 135.0, 124.0, 125.0, 151.0, 160.0, 128.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 157.0, 163.0, 154.0, 166.0, 161.0, 157.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 67.0, 66.0, 65.0, 65.0, 68.0, 86.0, 94.0, 95.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1474.8999999999996, "alertThreshold": 2.0}]} 21:54:10 INFO - Return code: 0 21:54:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:54:10 ERROR - # TBPL SUCCESS # 21:54:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:54:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:54:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:54:10 INFO - 2016-06-28 21:54:10.605 screenresolution[1678:10234] starting screenresolution argv=screenresolution get 21:54:10 INFO - 2016-06-28 21:54:10.608 screenresolution[1678:10234] Display 0: 1600x1200x32@60 21:54:10 INFO - 2016-06-28 21:54:10.614 screenresolution[1679:10237] starting screenresolution argv=screenresolution list 21:54:10 INFO - Available Modes on Display 0 21:54:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:54:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:54:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:54:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:54:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:54:10 INFO - Intel Iris: 21:54:10 INFO - Chipset Model: Intel Iris 21:54:10 INFO - Type: GPU 21:54:10 INFO - Bus: Built-In 21:54:10 INFO - VRAM (Dynamic, Max): 1536 MB 21:54:10 INFO - Vendor: Intel (0x8086) 21:54:10 INFO - Device ID: 0x0a2e 21:54:10 INFO - Revision ID: 0x0009 21:54:10 INFO - Displays: 21:54:10 INFO - Display: 21:54:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:54:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:54:10 INFO - Display Serial Number: 1600x1200 60 21:54:10 INFO - Main Display: Yes 21:54:10 INFO - Mirror: Off 21:54:10 INFO - Online: Yes 21:54:10 INFO - Rotation: Supported 21:54:10 INFO - Return code: 0 21:54:10 INFO - Running post-action listener: _resource_record_post_action 21:54:10 INFO - Running post-run listener: _resource_record_post_run 21:54:11 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 32349696; Write bytes: 492630016; Read time: 325; Write time: 1482 21:54:11 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 180879872; Write bytes: 175925248; Read time: 16393; Write time: 358 21:54:11 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 31428096; Write bytes: 296323072; Read time: 313; Write time: 1073 21:54:11 INFO - Running post-run listener: _upload_blobber_files 21:54:11 INFO - Blob upload gear active. 21:54:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:54:11 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 21:54:11 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'] 21:54:11 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 21:54:12 INFO - (blobuploader) - INFO - Open directory for files ... 21:54:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:54:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:54:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:13 INFO - (blobuploader) - INFO - Done attempting. 21:54:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:54:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:54:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:14 INFO - (blobuploader) - INFO - Done attempting. 21:54:14 INFO - (blobuploader) - INFO - Iteration through files over. 21:54:14 INFO - Return code: 0 21:54:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:54:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:54:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69957348a79a2b69e339d4e05b24d12d2912ca773d597259c1c4b81556c9b29d6b1bd383a67601cf025da2b8994371e9406ab6660f5b183857a5a72b5ec2c73d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e93de58dc3e7c3988d3e88785e709de6908dd8e999e4ee5a39bb905bbe975db2d7853ee07a822830633083cf3af1f234786cb5c50e12df32da5437fabcb00628"} 21:54:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:54:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:54:14 INFO - Contents: 21:54:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69957348a79a2b69e339d4e05b24d12d2912ca773d597259c1c4b81556c9b29d6b1bd383a67601cf025da2b8994371e9406ab6660f5b183857a5a72b5ec2c73d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e93de58dc3e7c3988d3e88785e709de6908dd8e999e4ee5a39bb905bbe975db2d7853ee07a822830633083cf3af1f234786cb5c50e12df32da5437fabcb00628"} 21:54:14 INFO - Running post-run listener: copy_logs_to_upload_dir 21:54:14 INFO - Copying logs to upload dir... 21:54:14 INFO - mkdir: /builds/slave/test/build/upload/logs 21:54:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.050423 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-28 21:54:14.392282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 21:54:14.395620) ========= 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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69957348a79a2b69e339d4e05b24d12d2912ca773d597259c1c4b81556c9b29d6b1bd383a67601cf025da2b8994371e9406ab6660f5b183857a5a72b5ec2c73d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e93de58dc3e7c3988d3e88785e709de6908dd8e999e4ee5a39bb905bbe975db2d7853ee07a822830633083cf3af1f234786cb5c50e12df32da5437fabcb00628"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010994 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467151137/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69957348a79a2b69e339d4e05b24d12d2912ca773d597259c1c4b81556c9b29d6b1bd383a67601cf025da2b8994371e9406ab6660f5b183857a5a72b5ec2c73d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e93de58dc3e7c3988d3e88785e709de6908dd8e999e4ee5a39bb905bbe975db2d7853ee07a822830633083cf3af1f234786cb5c50e12df32da5437fabcb00628"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 21:54:14.427691) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 21:54:14.428021) ========= 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.TxyN8nHzey/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.J6x1pHX8Ur/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005157 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 21:54:14.477605) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 21:54:14.477925) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 21:54:14.478294) ========= ========= Total master_lag: 0.17 =========