builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0335 starttime: 1467525945.11 results: success (0) buildid: 20160701064957 builduid: dc81e5134e46498e86f7107f4128c56e revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.113491) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.113955) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.114261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.473320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.473898) ========= 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.APmO15TsVR/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.7OGKjV201o/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-02 23:05:45-- 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% 173M=0s 2016-07-02 23:05:45 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.439269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.937827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.938180) ========= 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.APmO15TsVR/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.7OGKjV201o/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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.021549 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.993651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:05:45.993967) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --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 5e6976a28642d4d159071e14fd3251d76b9c46fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.APmO15TsVR/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.7OGKjV201o/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-02 23:05:46,077 truncating revision to first 12 chars 2016-07-02 23:05:46,077 Setting DEBUG logging. 2016-07-02 23:05:46,077 attempt 1/10 2016-07-02 23:05:46,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e6976a28642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:05:47,274 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.464850 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:05:47.483381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.483765) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.484289) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.484689) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.507531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-02 23:05:47.507980) ========= /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.APmO15TsVR/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.7OGKjV201o/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 23:05:47 INFO - MultiFileLogger online at 20160702 23:05:47 in /builds/slave/test 23:05:47 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 23:05:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:05:47 INFO - {'append_to_log': False, 23:05:47 INFO - 'base_work_dir': '/builds/slave/test', 23:05:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:05:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:05:47 INFO - 'branch': 'Mozilla-Beta', 23:05:47 INFO - 'buildbot_json_path': 'buildprops.json', 23:05:47 INFO - 'config_files': ('talos/mac_config.py',), 23:05:47 INFO - 'default_actions': ('clobber', 23:05:47 INFO - 'read-buildbot-config', 23:05:47 INFO - 'download-and-extract', 23:05:47 INFO - 'populate-webroot', 23:05:47 INFO - 'create-virtualenv', 23:05:47 INFO - 'install', 23:05:47 INFO - 'run-tests'), 23:05:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:05:47 INFO - 'download_minidump_stackwalk': True, 23:05:47 INFO - 'download_symbols': 'ondemand', 23:05:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:05:47 INFO - 'tooltool.py': '/tools/tooltool.py', 23:05:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:05:47 INFO - '/tools/misc-python/virtualenv.py')}, 23:05:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:05:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:05:47 INFO - 'installer_path': 'installer.exe', 23:05:47 INFO - 'log_level': 'info', 23:05:47 INFO - 'log_name': 'talos', 23:05:47 INFO - 'log_to_console': True, 23:05:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:05:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:05:47 INFO - 'opt_config_files': (), 23:05:47 INFO - 'pip_index': False, 23:05:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:05:47 INFO - 'cmd': ('bash', 23:05:47 INFO - '-c', 23:05:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:05:47 INFO - 'enabled': True, 23:05:47 INFO - 'halt_on_failure': False, 23:05:47 INFO - 'name': 'check_screen_resolution'},), 23:05:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:05:47 INFO - 'cmd': ('bash', 23:05:47 INFO - '-c', 23:05:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:05:47 INFO - 'enabled': True, 23:05:47 INFO - 'halt_on_failure': False, 23:05:47 INFO - 'name': 'check_screen_resolution'},), 23:05:47 INFO - 'run_cmd_checks_enabled': True, 23:05:47 INFO - 'sps_profile': False, 23:05:47 INFO - 'sps_profile_interval': 0, 23:05:47 INFO - 'suite': 'dromaeojs', 23:05:47 INFO - 'system_bits': '32', 23:05:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:05:47 INFO - 'title': 't-yosemite-r7-0335', 23:05:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:05:47 INFO - 'use_talos_json': True, 23:05:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:05:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:05:47 INFO - 'work_dir': 'build'} 23:05:47 INFO - ##### 23:05:47 INFO - ##### Running clobber step. 23:05:47 INFO - ##### 23:05:47 INFO - Running pre-action listener: _resource_record_pre_action 23:05:47 INFO - Running main action method: clobber 23:05:47 INFO - rmtree: /builds/slave/test/build 23:05:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:05:49 INFO - Running post-action listener: _resource_record_post_action 23:05:49 INFO - ##### 23:05:49 INFO - ##### Running read-buildbot-config step. 23:05:49 INFO - ##### 23:05:49 INFO - Running pre-action listener: _resource_record_pre_action 23:05:49 INFO - Running main action method: read_buildbot_config 23:05:49 INFO - Using buildbot properties: 23:05:49 INFO - { 23:05:49 INFO - "project": "", 23:05:49 INFO - "product": "firefox", 23:05:49 INFO - "script_repo_revision": "production", 23:05:49 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 23:05:49 INFO - "repository": "", 23:05:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 23:05:49 INFO - "buildid": "20160701064957", 23:05:49 INFO - "pgo_build": "False", 23:05:49 INFO - "basedir": "/builds/slave/test", 23:05:49 INFO - "buildnumber": 26, 23:05:49 INFO - "slavename": "t-yosemite-r7-0335", 23:05:49 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 23:05:49 INFO - "platform": "yosemite_r7", 23:05:49 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 23:05:49 INFO - "branch": "mozilla-beta", 23:05:49 INFO - "repo_path": "releases/mozilla-beta", 23:05:49 INFO - "revision": "5e6976a28642d4d159071e14fd3251d76b9c46fa", 23:05:49 INFO - "stage_platform": "macosx64", 23:05:49 INFO - "builduid": "dc81e5134e46498e86f7107f4128c56e", 23:05:49 INFO - "slavebuilddir": "test" 23:05:49 INFO - } 23:05:49 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg. 23:05:49 INFO - Running post-action listener: _resource_record_post_action 23:05:49 INFO - ##### 23:05:49 INFO - ##### Running download-and-extract step. 23:05:49 INFO - ##### 23:05:49 INFO - Running pre-action listener: _resource_record_pre_action 23:05:49 INFO - Running main action method: download_and_extract 23:05:49 INFO - mkdir: /builds/slave/test/build/tests 23:05: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')]} 23:05:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.test_packages.json 23:05:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 23:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/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 23:05:49 INFO - Downloaded 1165 bytes. 23:05:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 23:05:49 INFO - Using the following test package requirements: 23:05:49 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 23:05:49 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 23:05:49 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 23:05:49 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 23:05:49 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 23:05:49 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 23:05:49 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 23:05:49 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 23:05:49 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 23:05:49 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 23:05:49 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 23:05: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')]} 23:05:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.common.tests.zip 23:05:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 23:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/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 23:05:50 INFO - Downloaded 18351376 bytes. 23:05:50 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'] 23:05:50 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 23:05:53 INFO - Return code: 0 23:05:53 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 23:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.common.tests.zip 23:05:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 23:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/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 23:05:53 INFO - Downloaded 18351376 bytes. 23:05:53 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'] 23:05:53 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 23:05:57 INFO - Return code: 0 23:05: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')]} 23:05:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.talos.tests.zip 23:05:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 23:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/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 23:05:57 INFO - Downloaded 10840145 bytes. 23:05:57 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'] 23:05:57 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 23:05:57 INFO - Return code: 0 23:05: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')]} 23:05:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg 23:05:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 23:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 23:06:01 INFO - Downloaded 86193481 bytes. 23:06:01 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg 23:06:01 INFO - mkdir: /builds/slave/test/properties 23:06:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:06:01 INFO - Writing to file /builds/slave/test/properties/build_url 23:06:01 INFO - Contents: 23:06:01 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg 23:06:01 INFO - Running post-action listener: _resource_record_post_action 23:06:01 INFO - Running post-action listener: set_extra_try_arguments 23:06:01 INFO - ##### 23:06:01 INFO - ##### Running populate-webroot step. 23:06:01 INFO - ##### 23:06:01 INFO - Running pre-action listener: _resource_record_pre_action 23:06:01 INFO - Running main action method: populate_webroot 23:06:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:06:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:06:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:06:01 INFO - '--tppagecycles', 23:06:01 INFO - '7'], 23:06:01 INFO - 'tests': ['tsvgm']}}, 23:06:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:06:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:06:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:06:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:06:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:06:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:06:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:01 INFO - 'talos_options': ['--disable-e10s'], 23:06:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:01 INFO - 'talos_options': ['--disable-e10s'], 23:06:01 INFO - 'tests': ['damp', 'tps']}, 23:06:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:01 INFO - 'tests': ['damp', 'tps']}, 23:06:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:06:01 INFO - 'tests': ['dromaeo_dom']}, 23:06:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:06:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:06:01 INFO - 'tests': ['a11yr', 23:06:01 INFO - 'ts_paint', 23:06:01 INFO - 'tpaint', 23:06:01 INFO - 'sessionrestore', 23:06:01 INFO - 'sessionrestore_no_auto_restore', 23:06:01 INFO - 'tabpaint']}, 23:06:01 INFO - 'other-e10s': {'tests': ['a11yr', 23:06:01 INFO - 'ts_paint', 23:06:01 INFO - 'tpaint', 23:06:01 INFO - 'sessionrestore', 23:06:01 INFO - 'sessionrestore_no_auto_restore', 23:06:01 INFO - 'tabpaint']}, 23:06:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:06:01 INFO - 'ts_paint', 23:06:01 INFO - 'tpaint', 23:06:01 INFO - 'sessionrestore', 23:06:01 INFO - 'sessionrestore_no_auto_restore', 23:06:01 INFO - 'tabpaint']}, 23:06:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:06:01 INFO - 'ts_paint', 23:06:01 INFO - 'tpaint', 23:06:01 INFO - 'sessionrestore', 23:06:01 INFO - 'sessionrestore_no_auto_restore', 23:06:01 INFO - 'tabpaint']}, 23:06:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:06:01 INFO - 'tests': ['a11yr', 23:06:01 INFO - 'ts_paint', 23:06:01 INFO - 'tpaint', 23:06:01 INFO - 'sessionrestore', 23:06:01 INFO - 'sessionrestore_no_auto_restore', 23:06:01 INFO - 'tabpaint']}, 23:06:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:06:01 INFO - 'tests': ['a11yr', 23:06:01 INFO - 'ts_paint', 23:06:01 INFO - 'tpaint', 23:06:01 INFO - 'sessionrestore', 23:06:01 INFO - 'sessionrestore_no_auto_restore', 23:06:01 INFO - 'tabpaint']}, 23:06:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:06:01 INFO - 'tests': ['tsvgx', 23:06:01 INFO - 'tsvgr_opacity', 23:06:01 INFO - 'tart', 23:06:01 INFO - 'tscrollx', 23:06:01 INFO - 'cart']}, 23:06:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:06:01 INFO - 'tsvgr_opacity', 23:06:01 INFO - 'tart', 23:06:01 INFO - 'tscrollx', 23:06:01 INFO - 'cart']}, 23:06:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:01 INFO - 'talos_options': ['--disable-e10s'], 23:06:01 INFO - 'tests': ['tp5o']}, 23:06:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:01 INFO - 'tests': ['tp5o']}, 23:06:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:01 INFO - 'talos_options': ['--disable-e10s', 23:06:01 INFO - '--xperf_path', 23:06:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:01 INFO - 'tests': ['tp5n']}, 23:06:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:01 INFO - 'talos_options': ['--xperf_path', 23:06:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:01 INFO - 'tests': ['tp5n']}}, 23:06:01 INFO - 'talos.zip': {'path': '', 23:06:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:06:01 INFO - Running post-action listener: _resource_record_post_action 23:06:01 INFO - ##### 23:06:01 INFO - ##### Running create-virtualenv step. 23:06:01 INFO - ##### 23:06:01 INFO - Running pre-action listener: _resource_record_pre_action 23:06:01 INFO - Running main action method: create_virtualenv 23:06:01 INFO - Creating virtualenv /builds/slave/test/build/venv 23:06:01 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 23:06:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:06:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:06:01 INFO - Using real prefix '/tools/python27' 23:06:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:06:02 INFO - Installing distribute.............................................................................................................................................................................................done. 23:06:05 INFO - Installing pip.................done. 23:06:05 INFO - Return code: 0 23:06:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca23420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd61b4d9920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b2e00>, '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 0x10c71bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8adb20>, '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.APmO15TsVR/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.7OGKjV201o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 23:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APmO15TsVR/Render', 23:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:05 INFO - 'HOME': '/Users/cltbld', 23:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:05 INFO - 'LOGNAME': 'cltbld', 23:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:05 INFO - 'MOZ_NO_REMOTE': '1', 23:06:05 INFO - 'NO_EM_RESTART': '1', 23:06:05 INFO - 'PAGER': '/bin/cat', 23:06:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:05 INFO - 'PWD': '/builds/slave/test', 23:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:05 INFO - 'SHELL': '/bin/bash', 23:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OGKjV201o/Listeners', 23:06:05 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 23:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:05 INFO - 'USER': 'cltbld', 23:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:05 INFO - 'XPC_FLAGS': '0x0', 23:06:05 INFO - 'XPC_SERVICE_NAME': '0', 23:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:05 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 23:06:05 INFO - Cleaning up... 23:06:05 INFO - Return code: 0 23:06:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ca13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca23420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd61b4d9920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b2e00>, '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 0x10c71bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8adb20>, '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.APmO15TsVR/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.7OGKjV201o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 23:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APmO15TsVR/Render', 23:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:05 INFO - 'HOME': '/Users/cltbld', 23:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:05 INFO - 'LOGNAME': 'cltbld', 23:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:05 INFO - 'MOZ_NO_REMOTE': '1', 23:06:05 INFO - 'NO_EM_RESTART': '1', 23:06:05 INFO - 'PAGER': '/bin/cat', 23:06:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:05 INFO - 'PWD': '/builds/slave/test', 23:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:05 INFO - 'SHELL': '/bin/bash', 23:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OGKjV201o/Listeners', 23:06:05 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 23:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:05 INFO - 'USER': 'cltbld', 23:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:05 INFO - 'XPC_FLAGS': '0x0', 23:06:05 INFO - 'XPC_SERVICE_NAME': '0', 23:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:06 INFO - Downloading/unpacking psutil>=0.7.1 23:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:06:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:09 INFO - Installing collected packages: psutil 23:06:09 INFO - Running setup.py install for psutil 23:06:09 INFO - building 'psutil._psutil_osx' extension 23:06:09 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 23:06:09 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 23:06:09 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 23:06:09 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 23:06:09 INFO - building 'psutil._psutil_posix' extension 23:06:09 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 23:06:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:06:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:06:09 INFO - ^ 23:06:09 INFO - 1 warning generated. 23:06:09 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 23:06:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:10 INFO - Successfully installed psutil 23:06:10 INFO - Cleaning up... 23:06:10 INFO - Return code: 0 23:06:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:06:10 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')]} 23:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:10 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')]} 23:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:10 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 0x10ca13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca23420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd61b4d9920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b2e00>, '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 0x10c71bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8adb20>, '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.APmO15TsVR/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.7OGKjV201o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 23:06:10 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 23:06:10 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 23:06:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APmO15TsVR/Render', 23:06:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:10 INFO - 'HOME': '/Users/cltbld', 23:06:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:10 INFO - 'LOGNAME': 'cltbld', 23:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:10 INFO - 'MOZ_NO_REMOTE': '1', 23:06:10 INFO - 'NO_EM_RESTART': '1', 23:06:10 INFO - 'PAGER': '/bin/cat', 23:06:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:10 INFO - 'PWD': '/builds/slave/test', 23:06:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:10 INFO - 'SHELL': '/bin/bash', 23:06:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OGKjV201o/Listeners', 23:06:10 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 23:06:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:10 INFO - 'USER': 'cltbld', 23:06:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:10 INFO - 'XPC_FLAGS': '0x0', 23:06:10 INFO - 'XPC_SERVICE_NAME': '0', 23:06:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:06:12 INFO - Installing collected packages: mozsystemmonitor 23:06:12 INFO - Running setup.py install for mozsystemmonitor 23:06:13 INFO - Successfully installed mozsystemmonitor 23:06:13 INFO - Cleaning up... 23:06:13 INFO - Return code: 0 23:06:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:06:13 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')]} 23:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:13 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')]} 23:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:13 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 0x10ca13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca23420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd61b4d9920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b2e00>, '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 0x10c71bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8adb20>, '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.APmO15TsVR/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.7OGKjV201o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 23:06:13 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 23:06:13 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 23:06:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APmO15TsVR/Render', 23:06:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:13 INFO - 'HOME': '/Users/cltbld', 23:06:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:13 INFO - 'LOGNAME': 'cltbld', 23:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:13 INFO - 'MOZ_NO_REMOTE': '1', 23:06:13 INFO - 'NO_EM_RESTART': '1', 23:06:13 INFO - 'PAGER': '/bin/cat', 23:06:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:13 INFO - 'PWD': '/builds/slave/test', 23:06:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:13 INFO - 'SHELL': '/bin/bash', 23:06:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OGKjV201o/Listeners', 23:06:13 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 23:06:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:13 INFO - 'USER': 'cltbld', 23:06:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:13 INFO - 'XPC_FLAGS': '0x0', 23:06:13 INFO - 'XPC_SERVICE_NAME': '0', 23:06:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:13 INFO - Downloading/unpacking blobuploader==1.2.4 23:06:13 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 23:06:13 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 23:06:13 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 23:06:13 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 23:06:13 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 23:06:13 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 23:06:15 INFO - Downloading blobuploader-1.2.4.tar.gz 23:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:06:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:06:15 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 23:06:15 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 23:06:15 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 23:06:15 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 23:06:15 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 23:06:15 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 23:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:06:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:06:16 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 23:06:16 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 23:06:16 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 23:06:16 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 23:06:16 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 23:06:16 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 23:06:17 INFO - Downloading docopt-0.6.1.tar.gz 23:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:06:17 INFO - Installing collected packages: blobuploader, requests, docopt 23:06:17 INFO - Running setup.py install for blobuploader 23:06:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:06:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:06:17 INFO - Running setup.py install for requests 23:06:17 INFO - Running setup.py install for docopt 23:06:17 INFO - Successfully installed blobuploader requests docopt 23:06:17 INFO - Cleaning up... 23:06:18 INFO - Return code: 0 23:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:18 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 0x10ca13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca23420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd61b4d9920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b2e00>, '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 0x10c71bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8adb20>, '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.APmO15TsVR/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.7OGKjV201o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 23:06:18 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 23:06:18 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 23:06:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APmO15TsVR/Render', 23:06:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:18 INFO - 'HOME': '/Users/cltbld', 23:06:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:18 INFO - 'LOGNAME': 'cltbld', 23:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:18 INFO - 'MOZ_NO_REMOTE': '1', 23:06:18 INFO - 'NO_EM_RESTART': '1', 23:06:18 INFO - 'PAGER': '/bin/cat', 23:06:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:18 INFO - 'PWD': '/builds/slave/test', 23:06:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:18 INFO - 'SHELL': '/bin/bash', 23:06:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OGKjV201o/Listeners', 23:06:18 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 23:06:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:18 INFO - 'USER': 'cltbld', 23:06:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:18 INFO - 'XPC_FLAGS': '0x0', 23:06:18 INFO - 'XPC_SERVICE_NAME': '0', 23:06:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:18 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-Hvqm1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:18 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-Sovws3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:18 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-1PRuqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:18 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-RGB5G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:18 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-HtfG5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:18 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-AMebQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:18 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-WqVnIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:19 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-jhfISG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:19 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-xrOCTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:19 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-dwNH7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:19 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-FBtPDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:19 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-AxEjcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:19 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-kTWySR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:19 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-imiu9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:19 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-Q6DD5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:19 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-KfPAC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:20 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-aXQ_49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:06:20 INFO - Running setup.py install for manifestparser 23:06:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:06:20 INFO - Running setup.py install for mozcrash 23:06:20 INFO - Running setup.py install for mozdebug 23:06:20 INFO - Running setup.py install for mozdevice 23:06:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:20 INFO - Running setup.py install for mozfile 23:06:20 INFO - Running setup.py install for mozhttpd 23:06:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Running setup.py install for mozinfo 23:06:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Running setup.py install for mozInstall 23:06:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Running setup.py install for mozleak 23:06:21 INFO - Running setup.py install for mozlog 23:06:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Running setup.py install for moznetwork 23:06:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Running setup.py install for mozprocess 23:06:21 INFO - Running setup.py install for mozprofile 23:06:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:06:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:06:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:06:22 INFO - Running setup.py install for mozrunner 23:06:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:06:22 INFO - Running setup.py install for mozscreenshot 23:06:22 INFO - Running setup.py install for moztest 23:06:22 INFO - Running setup.py install for mozversion 23:06:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:22 INFO - Cleaning up... 23:06:22 INFO - Return code: 0 23:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:22 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 0x10ca13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca23420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd61b4d9920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b2e00>, '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 0x10c71bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8adb20>, '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.APmO15TsVR/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.7OGKjV201o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 23:06:22 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 23:06:22 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 23:06:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APmO15TsVR/Render', 23:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:22 INFO - 'HOME': '/Users/cltbld', 23:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:22 INFO - 'LOGNAME': 'cltbld', 23:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:22 INFO - 'MOZ_NO_REMOTE': '1', 23:06:22 INFO - 'NO_EM_RESTART': '1', 23:06:22 INFO - 'PAGER': '/bin/cat', 23:06:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:22 INFO - 'PWD': '/builds/slave/test', 23:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:22 INFO - 'SHELL': '/bin/bash', 23:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OGKjV201o/Listeners', 23:06:22 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 23:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:22 INFO - 'USER': 'cltbld', 23:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:22 INFO - 'XPC_FLAGS': '0x0', 23:06:22 INFO - 'XPC_SERVICE_NAME': '0', 23:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:22 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-EHoNyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:23 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)) 23:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-I3pTUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:23 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)) 23:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-pTkPOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:23 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)) 23:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-IoJBsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:23 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)) 23:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-NxBdes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:23 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)) 23:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-7HAQbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:23 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)) 23:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-eepPzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:23 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)) 23:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-eGZyuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:23 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)) 23:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-B2u3p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:23 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)) 23:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-MXcQmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:24 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)) 23:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-fCn_NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:24 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)) 23:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-GgvyQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:24 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)) 23:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-lRJhwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:24 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)) 23:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-wjYyFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:24 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)) 23:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-XwxSwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:24 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)) 23:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-sCnJk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:24 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)) 23:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-FqqrcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:24 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)) 23:06:24 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)) 23:06:24 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)) 23:06:24 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)) 23:06:24 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)) 23:06:24 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)) 23:06:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:24 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 23:06:24 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 23:06:24 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 23:06:24 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 23:06:24 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 23:06:24 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 23:06:27 INFO - Downloading blessings-1.6.tar.gz 23:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:06:27 INFO - Installing collected packages: blessings 23:06:27 INFO - Running setup.py install for blessings 23:06:27 INFO - Successfully installed blessings 23:06:27 INFO - Cleaning up... 23:06:27 INFO - Return code: 0 23:06:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:06:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:27 INFO - Reading from file tmpfile_stdout 23:06:27 INFO - Current package versions: 23:06:27 INFO - blessings == 1.6 23:06:27 INFO - blobuploader == 1.2.4 23:06:27 INFO - docopt == 0.6.1 23:06:27 INFO - manifestparser == 1.1 23:06:27 INFO - mozInstall == 1.12 23:06:27 INFO - mozcrash == 0.17 23:06:27 INFO - mozdebug == 0.1 23:06:27 INFO - mozdevice == 0.48 23:06:27 INFO - mozfile == 1.2 23:06:27 INFO - mozhttpd == 0.7 23:06:27 INFO - mozinfo == 0.9 23:06:27 INFO - mozleak == 0.1 23:06:27 INFO - mozlog == 3.1 23:06:27 INFO - moznetwork == 0.27 23:06:27 INFO - mozprocess == 0.22 23:06:27 INFO - mozprofile == 0.28 23:06:27 INFO - mozrunner == 6.11 23:06:27 INFO - mozscreenshot == 0.1 23:06:27 INFO - mozsystemmonitor == 0.0 23:06:27 INFO - moztest == 0.7 23:06:27 INFO - mozversion == 1.4 23:06:27 INFO - psutil == 3.1.1 23:06:27 INFO - requests == 1.2.3 23:06:27 INFO - wsgiref == 0.1.2 23:06:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:27 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 0x10ca13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca23420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd61b4d9920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b2e00>, '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 0x10c71bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8adb20>, '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.APmO15TsVR/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.7OGKjV201o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 23:06:27 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 23:06:27 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 23:06:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APmO15TsVR/Render', 23:06:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:27 INFO - 'HOME': '/Users/cltbld', 23:06:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:27 INFO - 'LOGNAME': 'cltbld', 23:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:27 INFO - 'MOZ_NO_REMOTE': '1', 23:06:27 INFO - 'NO_EM_RESTART': '1', 23:06:27 INFO - 'PAGER': '/bin/cat', 23:06:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:27 INFO - 'PWD': '/builds/slave/test', 23:06:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:27 INFO - 'SHELL': '/bin/bash', 23:06:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OGKjV201o/Listeners', 23:06:27 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 23:06:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:27 INFO - 'USER': 'cltbld', 23:06:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:27 INFO - 'XPC_FLAGS': '0x0', 23:06:27 INFO - 'XPC_SERVICE_NAME': '0', 23:06:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:28 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)) 23:06:28 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)) 23:06:28 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)) 23:06:28 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)) 23:06:28 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)) 23:06:28 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)) 23:06:28 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)) 23:06:28 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)) 23:06:28 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)) 23:06:28 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)) 23:06:28 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)) 23:06:28 INFO - Cleaning up... 23:06:28 INFO - Return code: 0 23:06:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:06:28 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')]} 23:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:28 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')]} 23:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:28 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 0x10ca13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca23420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd61b4d9920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b2e00>, '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 0x10c71bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8adb20>, '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.APmO15TsVR/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.7OGKjV201o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 23:06:28 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 23:06:28 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 23:06:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APmO15TsVR/Render', 23:06:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:28 INFO - 'HOME': '/Users/cltbld', 23:06:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:28 INFO - 'LOGNAME': 'cltbld', 23:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:28 INFO - 'MOZ_NO_REMOTE': '1', 23:06:28 INFO - 'NO_EM_RESTART': '1', 23:06:28 INFO - 'PAGER': '/bin/cat', 23:06:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:28 INFO - 'PWD': '/builds/slave/test', 23:06:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:28 INFO - 'SHELL': '/bin/bash', 23:06:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OGKjV201o/Listeners', 23:06:28 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 23:06:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:28 INFO - 'USER': 'cltbld', 23:06:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:28 INFO - 'XPC_FLAGS': '0x0', 23:06:28 INFO - 'XPC_SERVICE_NAME': '0', 23:06:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:28 INFO - Downloading/unpacking jsonschema 23:06:28 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 23:06:28 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 23:06:28 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 23:06:28 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 23:06:28 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 23:06:28 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 23:06:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:06:30 INFO - Downloading/unpacking functools32 (from jsonschema) 23:06:30 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 23:06:30 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 23:06:30 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 23:06:30 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 23:06:30 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 23:06:30 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 23:06:31 INFO - Downloading functools32-3.2.3-2.tar.gz 23:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:06:31 INFO - warning: no files found matching '*.txt' 23:06:31 INFO - no previously-included directories found matching 'build' 23:06:31 INFO - no previously-included directories found matching 'dist' 23:06:31 INFO - no previously-included directories found matching '.git*' 23:06:31 INFO - Installing collected packages: jsonschema, functools32 23:06:31 INFO - Running setup.py install for functools32 23:06:31 INFO - warning: no files found matching '*.txt' 23:06:31 INFO - no previously-included directories found matching 'build' 23:06:31 INFO - no previously-included directories found matching 'dist' 23:06:31 INFO - no previously-included directories found matching '.git*' 23:06:31 INFO - Successfully installed jsonschema functools32 23:06:31 INFO - Cleaning up... 23:06:31 INFO - Return code: 0 23:06:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca23420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd61b4d9920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b2e00>, '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 0x10c71bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8adb20>, '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.APmO15TsVR/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.7OGKjV201o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 23:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APmO15TsVR/Render', 23:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:31 INFO - 'HOME': '/Users/cltbld', 23:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:31 INFO - 'LOGNAME': 'cltbld', 23:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:31 INFO - 'MOZ_NO_REMOTE': '1', 23:06:31 INFO - 'NO_EM_RESTART': '1', 23:06:31 INFO - 'PAGER': '/bin/cat', 23:06:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:31 INFO - 'PWD': '/builds/slave/test', 23:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:31 INFO - 'SHELL': '/bin/bash', 23:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OGKjV201o/Listeners', 23:06:31 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 23:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:31 INFO - 'USER': 'cltbld', 23:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:31 INFO - 'XPC_FLAGS': '0x0', 23:06:31 INFO - 'XPC_SERVICE_NAME': '0', 23:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:31 INFO - Downloading/unpacking flake8 23:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:31 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 23:06:31 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 23:06:31 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 23:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:31 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 23:06:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:06:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:06:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:06:35 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 23:06:35 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 23:06:35 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 23:06:35 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 23:06:35 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 23:06:35 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 23:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:06:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:35 INFO - no previously-included directories found matching 'docs/_build' 23:06:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:06:35 INFO - Running setup.py install for pep8 23:06:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:36 INFO - no previously-included directories found matching 'docs/_build' 23:06:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:06:36 INFO - Cleaning up... 23:06:36 INFO - Return code: 0 23:06:36 INFO - Running post-action listener: _resource_record_post_action 23:06:36 INFO - Running post-action listener: _start_resource_monitoring 23:06:36 INFO - Starting resource monitoring. 23:06:36 INFO - ##### 23:06:36 INFO - ##### Running install step. 23:06:36 INFO - ##### 23:06:36 INFO - Running pre-action listener: _resource_record_pre_action 23:06:36 INFO - Running main action method: install 23:06:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:36 INFO - Reading from file tmpfile_stdout 23:06:36 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:06:36 INFO - Reading from file tmpfile_stdout 23:06:36 INFO - Output received: 23:06:36 INFO - Usage: mozinstall [options] installer 23:06:36 INFO - Options: 23:06:36 INFO - -h, --help show this help message and exit 23:06:36 INFO - -d DEST, --destination=DEST 23:06:36 INFO - Directory to install application into. [default: 23:06:36 INFO - "/builds/slave/test"] 23:06:36 INFO - --app=APP Application being installed. [default: firefox] 23:06:36 INFO - mkdir: /builds/slave/test/build/application 23:06:36 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'] 23:06:36 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 23:06:58 INFO - Reading from file tmpfile_stdout 23:06:58 INFO - Output received: 23:06:58 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 23:06:58 INFO - Running post-action listener: _resource_record_post_action 23:06:58 INFO - ##### 23:06:58 INFO - ##### Running run-tests step. 23:06:58 INFO - ##### 23:06:58 INFO - Running pre-action listener: _resource_record_pre_action 23:06:58 INFO - Running main action method: run_tests 23:06:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:06:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:06:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:06:58 INFO - 2016-07-02 23:06:58.461 screenresolution[2345:47965] starting screenresolution argv=screenresolution get 23:06:58 INFO - 2016-07-02 23:06:58.464 screenresolution[2345:47965] Display 0: 1600x1200x32@60 23:06:58 INFO - 2016-07-02 23:06:58.470 screenresolution[2346:47968] starting screenresolution argv=screenresolution list 23:06:58 INFO - Available Modes on Display 0 23:06:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:06:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:06:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:06:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:06:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:06:58 INFO - Intel Iris: 23:06:58 INFO - Chipset Model: Intel Iris 23:06:58 INFO - Type: GPU 23:06:58 INFO - Bus: Built-In 23:06:58 INFO - VRAM (Dynamic, Max): 1536 MB 23:06:58 INFO - Vendor: Intel (0x8086) 23:06:58 INFO - Device ID: 0x0a2e 23:06:58 INFO - Revision ID: 0x0009 23:06:58 INFO - Displays: 23:06:58 INFO - Display: 23:06:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:06:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:06:58 INFO - Display Serial Number: 1600x1200 60 23:06:58 INFO - Main Display: Yes 23:06:58 INFO - Mirror: Off 23:06:58 INFO - Online: Yes 23:06:58 INFO - Rotation: Supported 23:06:58 INFO - Return code: 0 23:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:06:58 INFO - Python 2.7.3 23:06:58 INFO - Return code: 0 23:06:58 INFO - grabbing minidump binary from tooltool 23:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:58 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 0x10c8b2e00>, '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 0x10c71bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8adb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:06:58 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 23:06:58 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 23:06:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:06:58 INFO - Return code: 0 23:06:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:06:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:06:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:06:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:06:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:06:59 INFO - Return code: 0 23:06:59 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/1467380997/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0335', '--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 23:06:59 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/1467380997/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0335 --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 23:06:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APmO15TsVR/Render', 23:06:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:59 INFO - 'HOME': '/Users/cltbld', 23:06:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:59 INFO - 'LOGNAME': 'cltbld', 23:06:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:06:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:59 INFO - 'MOZ_NO_REMOTE': '1', 23:06:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:06:59 INFO - 'NO_EM_RESTART': '1', 23:06:59 INFO - 'PAGER': '/bin/cat', 23:06:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:59 INFO - 'PWD': '/builds/slave/test', 23:06:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:06:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:59 INFO - 'SHELL': '/bin/bash', 23:06:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OGKjV201o/Listeners', 23:06:59 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 23:06:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:59 INFO - 'USER': 'cltbld', 23:06:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:59 INFO - 'XPC_FLAGS': '0x0', 23:06:59 INFO - 'XPC_SERVICE_NAME': '0', 23:06:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:59 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/1467380997/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0335', '--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 23:07:00 INFO - mozversion application_buildid: 20160701064957 23:07:00 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:07:00 INFO - mozversion application_display_name: Firefox 23:07:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:07:00 INFO - mozversion application_name: Firefox 23:07:00 INFO - mozversion application_remotingname: firefox 23:07:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:07:00 INFO - mozversion application_vendor: Mozilla 23:07:00 INFO - mozversion application_version: 48.0 23:07:00 INFO - mozversion platform_buildid: 20160701064957 23:07:00 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:07:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:07:00 INFO - mozversion platform_version: 48.0 23:07:00 INFO - using testdate: 1467526020 23:07:00 INFO - actual date: 1467526020 23:07:00 INFO - starting webserver on 'localhost:51035' 23:07:00 INFO - SUITE-START | Running 2 tests 23:07:00 INFO - TEST-START | dromaeo_css 23:07:00 INFO - operating with platform_type : mac_ 23:07:00 INFO - Initialising browser for dromaeo_css test... 23:07:00 INFO - TEST-INFO | started process 2364 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmpc68jUn/profile http://localhost:51035/getInfo.html) 23:07:02 INFO - PROCESS | 2364 | __metrics Screen width/height:1600/1200 23:07:02 INFO - PROCESS | 2364 | colorDepth:24 23:07:02 INFO - PROCESS | 2364 | Browser inner width/height: 1024/689 23:07:02 INFO - PROCESS | 2364 | __metrics 23:07:02 INFO - PROCESS | 2364 | 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" 23:07:02 ERROR - PROCESS | 2364 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:07:03 INFO - TEST-INFO | 2364: exit 0 23:07:03 INFO - Browser initialized. 23:07:03 INFO - Running cycle 1/1 for dromaeo_css test... 23:07:03 INFO - TEST-INFO | started process 2367 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmpc68jUn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:15 INFO - PROCESS | 2367 | RSS: Main: 161513472 23:07:15 INFO - PROCESS | 2367 | 23:08:06 INFO - PROCESS | 2367 | 1467526086289 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] 23:10:15 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51035/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51035/tests/dromaeo/cssquery-ext.html) 23:10:17 INFO - PROCESS | 2367 | RSS: Main: 257441792 23:10:17 INFO - PROCESS | 2367 | 23:13:19 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51035/tests/dromaeo/cssquery-ext.html (next: http://localhost:51035/tests/dromaeo/cssquery-jquery.html) 23:13:20 INFO - PROCESS | 2367 | RSS: Main: 306343936 23:13:20 INFO - PROCESS | 2367 | 23:16:22 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51035/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51035/tests/dromaeo/cssquery-mootools.html) 23:16:23 INFO - PROCESS | 2367 | RSS: Main: 312102912 23:16:23 INFO - PROCESS | 2367 | 23:19:25 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51035/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51035/tests/dromaeo/cssquery-prototype.html) 23:19:25 INFO - PROCESS | 2367 | RSS: Main: 310935552 23:19:25 INFO - PROCESS | 2367 | 23:22:28 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51035/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51035/tests/dromaeo/cssquery-yui.html) 23:22:29 INFO - PROCESS | 2367 | RSS: Main: 275214336 23:22:29 INFO - PROCESS | 2367 | 23:25:31 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51035/tests/dromaeo/cssquery-yui.html (next: http://localhost:51035/tests/dromaeo/cssquery-dojo.html) 23:25:32 INFO - PROCESS | 2367 | RSS: Main: 323096576 23:25:32 INFO - PROCESS | 2367 | 23:25:32 INFO - PROCESS | 2367 | __start_tp_report 23:25:32 INFO - PROCESS | 2367 | _x_x_mozilla_page_load 23:25:32 INFO - PROCESS | 2367 | _x_x_mozilla_page_load_details 23:25:32 INFO - PROCESS | 2367 | |i|pagename|runs| 23:25:32 INFO - PROCESS | 2367 | |0;dojo.html;3215.64627890932;3516.138546056216;3589.5154154189177;3610.169660977974;3620.5293311869455;5907.232059832221;5910.822675319747;5911.970440147804;5918.171455996153;5940.108983652449;5926.674032928187;5952.88094238115;5955.225820643311;5958.404159584039;5964.612300200495;5227.294315267447;5248.973755131219;5267.157254839227;5344.518993290603;5394.487523685244;5303.522682958533;5318.973405132969;5331.706756128411;5335.173048177519;5340.599455040868;5281.683099014072;5331.120365139747;5332.733363331838;5347.491988261109;5370.91943620846;5345.812896548621;5368.221607866876;5377.247185394048;5385.353757549119;5406.324209473816;5159.993801208766;5242.501962313574;5298.655587386807;5300.204969254604;5319.813806516753;5764.193012978187;5785;5788.305403351583;5815.273090863642;5841.824745257649;6301.684915754194;6308.053791931247;6310.242770867525;6324.367563243685;6349.904751428732;6174.289956654952;6268.843278918018;6313.842153946142;6318.368163183645;6319.020551814476;5029.245613158056;6011.729472173719;6072.817815465543;6088.756449742049;6107.083937409424;6354.809355719336;6389.041643753474;6401.58389704677;6408.198975128109;6412.39082287182;5030.37120359955;6166.691665416801;6326.905096423558;6347.936520634827;6348.746050157942;6314.400131987454;6321.146645202931;6334.5565810393755;6335.968320158462;6343.460805831556;6279.995200767855;6343.175387199634;6355.809325720235;6358.745650173942;6373.075903993895;6266.780662676784;6282.151909492251;6313.463355614824;6340.682965851689;6355.777547785805;5001.89996200074;5032.72320022395;5036.370453693288;5050.772715227824;5051.848444546669;4524.366588677522;4529.614982726505;4535.750533720611;4573.931391029138;4578.381918440968;5867.471927526543;5974.701264936736;5979.5814292999075;5983.640981541122;6030.577859549877;6293.087502312139;6317.778877739349;6325.683715814191;6332.588381755171;6342.4926005919415;6011.7595296187665;6025.548083893726;6027.60820546663;6027.78902738402;6050.667213303311;5450.264214331015;5511.834644960658;5516.3380394352935;5539.362973258127;5554.750036248379;6446.645434501053;6483.481321494363;6499.935000650122;6506.934930650633;6511.446527045159;6338.8732225354315;6339.922213223671;6350.269718982377;6354.555181137276;6365.108884756045;6314.842128946813;6421.101045853491;6459.418652321314;6502.284748677736;6502.447291980235;6216.44052035319;6334.90497642545;6337.7781777637565;6376.52176086786;6394.97680371157;6308.369163083655;6333.65164915934;6337.4613157882095;6347.460465860454;6359.650219237987;5633.802816901389;5928.4960778334325;6148.292946311231;6306.337834527492;6347.71435285404;6274.560780745304;6311.116443697794;6313;6322.272938612118;6329.715162817776;6031.668258245839;6146.78486252979;6181.783637572664;6198.938010620016;6211.472024877936;5084.847454576368;5806.216160818235;6221.564490485623;6310.873782524415;6343.0485427186295;6174.073888916699;6192.721327540362;6202.069689546604;6206.658633775186;6226.5641405101205 23:25:32 INFO - PROCESS | 2367 | |1;ext.html;535.210564417484;543.7906406033677;560.2017125596025;598.814367546061;604.9122877182808;32921.67078329216;33548.49677254843;33572.16069598261;33585;33599.83200083999;34902.65097349026;41572.16855662885;41890.95272618186;42054.94862628436;42071.579284207226;9638.325317227815;9834.114929656329;9841.606335746561;9856.112949834513;9859.260555458333;9014.909850901473;9708.174805141536;9826.263030272723;9829.262805289596;9831.410115393099;11851.111166662491;12074.094442916816;12128.272303661764;12132.454039568196;12140.878591214107;11874.28754274742;11985.940070299594;11992.64022079339;12004.639860804189;12005.939970300136;11839.704007399798;11959.760804783855;11971.281723096643;12016.63950081499;12026.15816892818;42785.71642850719;42954.57045429537;43023.56976430227;43304.78347608273;43315;3334.2497937963763;3373.207296285371;3385.2044769479153;3393.100828280508;3456.6716161964573;29086.854565727037;29127;31068.689313107032;31140.377192456024;31412.37175256482;2845.416689578652;2855.0721015669783;2879.956800647992;2899.9710002900124;2908.403777225664;410418;410455;410584;411641;413791;38763;39221;39495.802520987214;56391;70618.64690676513;36659.90020299395;36784.448233276526;36859.26281474355;36862.631373686454;36919.89240322741;16341.754873676904;16525.91737041307;16540.91729541369;16568.17159142038;16585.83414165843;13757.38091785852;13824.101433406797;13846.861531384759;13853.722925541635;13853.930730346485;7351.963240183765;8051.879221811678;8182.713605023796;8566.400351975302;8717.953845538575;2995.7902946793515;3016.638003439601;3499.9300013999577;3541.220931395089;3561.3411518869093;993.4138858073627;1023.959041638341;1031.2677998620914;1058.1534772182224;1066.3814987307344;30599.455176075135;31490.842545787124;31542.684573154434;31715.36569268648;32294.677053229167;1167.2821214952912;1237.8205160251894;1254.9749005019848;1271.6375832887582;1271.8918891894107;15804;16032.19839008045;16128.870979031355;16325.67348653044;16505.917470412573;645157;649258;659296.7035164793;659991;660996;64054.67972660107;64847.67576162089;64897;65196.674016629615;65857.34142658608;1381.412899517701;1559.4308077551611;1572.4024870549117;1581.675756469921;1634.0277534866734;29401.55897661494;29837.5524367139;29858.253543661584;29992.85003574968;30474;49641.751791242255;49737.75131124321;50265.24602131044;50300.748496257285;50326.99346013132;320933;322204;323336;323551;324184;24954.251372458857;28346.149615511567;29062.41875162527;29345.85327073351;29551.113466595176;43871.56128438802;44150;44257;45275.77362113168;45351.77324113358;32286.869959551303;33568.83215583907;37186.6281337194;38449.42325865058;39429.61996330115;37966;38258.85223443301;38273.4258986121;38586.807065965615;39142.80428597839;37773.62226377811;38284.234315312984;38377.232455350175;38466.0383490415;38595;32646.878565769723;34194.97415077552;34195.82902085473;34498.31003379969;34546.827265864515;25198.62202067007;25351.239462816146;25563.872180638977;25850.836712347613;26000.8699956499 23:25:32 INFO - PROCESS | 2367 | |2;jquery.html;411.56785375355867;413.5946772163282;416.2299745470879;418.9099343641117;423.1600273457189;19213.807861921377;20645;21058.157673693033;21343.57312853742;21389.893050534763;20160.899195504004;20362.490937726565;21366.465838354048;21386.57226855462;21391.893040534775;5855.707214639262;5942.584019118642;6236;6242.781502647408;6243.781467648633;5413.377461591908;6009.729562169691;6139.2325959255095;6173.413525715072;6207.720652570622;5950.732217050221;6227.595206311598;6228.875422491547;6234.407731265523;6255.687215639223;5756.539476841885;6145.477634401082;6205.658688772116;6219.129321894893;6227.221597300338;4831.033793241366;6022.126791615235;6036.698165091728;6043.848903777397;6072.392760723937;18029.82806117598;25674.358141046436;26470.205893823215;26479.338016549547;26584.73415265842;1887.867849250553;2177.031221106608;2195.3413975807352;2282.4864405508793;2734.4257705881787;8604.31165506758;9756.95121524395;9860.260480463921;10112.646057387956;10327.948360258226;1652.8512433881008;1748.3443708609273;1765.5497848048665;1800.189914538463;1801.1714611278828;68422.65788671075;68520.6573967132;72302;113938;120086.39956800247;9589;11744.70638234051;11837.526498939946;11894.524219031315;11975.880241197476;15346.232688365537;15430.38278468871;15537.223138843012;15572.688546229012;15577.766333505006;7726.0342457192855;9238.214751746042;9297.163255307054;9313.161815436642;9332.953335233417;9417.199538039207;9425.528723563795;9442.48066356357;9446.763830904283;9516.476593787409;4682.321063445781;4741.810327586927;4757.524247575215;4760.714357138583;4807.5817633798115;1979.2676709617533;2005.5186755178652;2025.3215172917237;2033.3696554068285;2034.7660019097698;858.553337626102;973.2894986659778;995.9800803983879;1028.9897101028894;1064.0211005874614;16893;20260.493487662927;20263.594728105356;20705.792942070686;20877.37367878966;969.539468752337;979.9657012004545;1003.3879333606494;1024.2267088348249;1044.9216308776872;10751.892481075089;11010.614628487965;11058.502367393487;11108.55565777376;11279.887201128047;620393;634377;669495;675328;679688;120467;121436.39281803711;127335.36332318465;129136;130740;1014.8477728340808;1030.953607087683;1031.118393773328;1035.2184101003695;1061.6868023932805;14614.488492902698;17259.22333495021;17977.191026403583;18099.63800723952;18271.725924111415;48008.07967681254;48545.7863553414;53871.19193212183;53901.65245868728;55061;77435;77543;78173.82739258802;78586;78725.21274787179;8210.302124319262;8211.917880821355;8263.338932885235;8350.540720260444;8598.914010860062;12538.498460061495;12717.173383730027;12745.916597089352;12758.744825103631;12788.936055320037;7431.962840185764;10934.671959841218;10982.560697572007;11216.2148649597;11467.426628668367;10766.67699968971;10837.891621084003;10929.83605245906;11189.496472658913;11217.607383741857;9601.951990240004;11256.606018789304;11304.717382065186;11328.886711132784;11467.025302849352;8103;8201.548914809742;8261.008678958564;8299.460535065202;8463.788405289917;10819.1344692426;11027.558897644005;11189.832152517556;11199.552017919517;11394.715132121763 23:25:32 INFO - PROCESS | 2367 | |3;mootools.html;1497.6255936015996;1627.967440651187;1643.7123503386904;1890.4990177602938;2000.159932828212;8146.511209327437;8752.91247087529;8871.290296776258;8874.645014199425;8908;8623.267022303111;8836.8674469883;8856.11438856114;8861.601227944742;8866.02473727891;2477.55404027275;2508.623706444039;2510.3222130024883;2510.9372265693323;2511.6985961684622;2354.799842013431;2408.349745568695;2411.7105947286263;2419.2258477287187;2428.963565546518;2453.0678342229926;2470.3700556358103;2530.1903390914913;2530.291518374858;2531.835430697008;2454.8649824259746;2490.8754562271906;2499.4001439654535;2501.987490062538;2504.261242933339;2440.707115146176;2470.7035155781423;2478.3927937655208;2488.8133389995824;2504.586743187372;8688.739337819876;8897.377183597151;8973.461592304417;8999.055099214555;9044.41211321262;5395.865103372408;5580;5583.441655834384;5592.944070559283;5612.607117501777;3056.923576910595;3621.764585301947;3647.1246900743895;3694.8891533254045;3727.9068023299365;1064.302881612545;1074.785042991405;1079.838024296354;1083.3716444462273;1084.1001968366238;12031.27812331263;12095.39523023854;12186.451609677497;12254.387280636021;12257.57098501557;4011.338129208648;4626.4910859805395;4750.8337208197545;4759.50025247351;4770.689905156154;9414.717558473258;9422.623095076257;9424.481653508985;9424.481653509123;9424.575894084783;5436.565074794007;5450.645708028966;5468.890622187534;5472.315960504937;5498.972505137449;4547.226971414867;4693.83571575;4939.753012349368;5022.497750225021;5099.6685215460875;3821.8662346817728;3850.268448994682;3860.401637746154;3953.9011524711536;3974.503187101612;1002.8796544414571;1176.7175877789268;1224.4979558381021;1238.1642391385958;1239.1573729863599;853.6158728572167;961.2550273538064;993.2352088891513;1001.5593139018808;1010.0858722855827;5904.881902361929;5992.0712289595185;6044.335123136451;6053.636781793107;6260.686965651699;456.8766433063054;474.6772194907496;475.9932742250116;479.1160309229466;482.4042307749926;3819.8090095495113;3873.2447172801035;3917.6865850731874;3990.9002274942777;4023.054582173187;10700.518476668569;11138.164637652208;11148;11168.553257869757;11170.720731981766;10708.19688523364;10851.728706782395;10958.671239862817;11006.614768483225;11013.118950483942;8545.273651739672;8565.571721413904;8572.742817715478;8598.441101328393;8636.352273579507;5591.552675785846;5826.766929322949;5834;5910.290765108042;5930.288365396007;9689.12797848197;9808.607655693977;9881.901180988385;9998.350107243006;10049.69850904474;10002.199824014207;10007.399556026661;10071;10293.485325733534;10338.741531461774;6398.87202255943;6562.409383155539;6579.736810527525;7089.042979197742;7175.820604484721;7691.5769632670745;8063.959680201561;8439.156084391758;8441.451305665112;8494.660213591387;7305.525140865827;7437.888431673638;7532.962335188289;7632.542047477169;7678.808029799076;7101.609411482212;7230.45771567124;7262.745803896838;7305.963470182615;7332.376747976482;6577.901331480128;6598.241202261609;6656.966715166393;6667.333266673294;6682.899756503753;4886.828960986349;4919.0899683558655;4923.532264434873;5002.87492812668;5006.899862002667;4922.040202160544;4964.975175124101;5068.847934561969;5076.289319495199;5251.36983561975 23:25:32 INFO - PROCESS | 2367 | |4;prototype.html;323.4856578040916;326.07882731284116;338.1748533578069;340.51986698754763;340.6746557038029;6494.772682956098;6695.296993815647;6709.496787740921;6735.865282694349;6833.145856767904;5361.839144825662;6647.734090636369;6717.059611654372;6743.865122697555;6795.932040679591;4998.100341938459;5009.749512524378;5012.298278241049;5021.748912554376;5022.799088036492;4073.307537718595;5021.046001259767;5025.246213068051;5037.143685573443;5056.241563765446;4957.082939656157;4961.007798440309;4973.52751488608;4974.278729584208;4994.800207991676;4970.254461830718;4974.9751251243515;4987.650864439473;4995.225740010304;5001.624878134136;3705.0366904604725;3974.284628766821;4103.076807718269;4117.3618089195925;4135.958640413587;5818.505427038707;6349.777757778502;6441.130447389589;6457.580257283262;6478.481721462272;4632.884177895546;5724.313082430135;5739.655620662732;5746.396628354005;5748.741306641211;5678.772849086032;7114.501984861062;7121.608311542915;7133.607651579161;7134.964325178393;4622.075584883003;4631.120087183424;4641.280601506772;4642.0715856828765;4649.279361698942;7153.177384600734;7250.637468126625;7431.814204644819;7534.171241163468;7556.546607203585;4551.271796512542;4613.169629466728;4618.699784513996;4620.330052142421;4707.435107787019;4741.407324084489;4774.641901857305;4785.545373189541;4790.760461976887;4811.663183577116;4766.571008609242;5392.73036348181;5696.8006119785605;5703.572232082611;5707.600467967202;7126.643667816588;7131.358177764027;7142.535735177197;7144.571325720473;7153;1618.6600813828993;1649.554620252549;1652.5703317137632;1654.3796076471324;1654.6525229701656;1034.6637342863598;1039.77644806367;1059.7244716373798;1064.973375665599;1068.8663917010374;5438.7280635968045;6730.091437655951;6784.457243420613;6788.879834827297;6820.079289295882;5985.521158307325;7445.441591880631;7450.813729656694;7467.738629147953;7471.626418679044;6767.593944363354;6781.62701051437;6786.491013174032;6790.1851777786;6796.898046529306;3796.8291426885858;3923.5684074751753;3968.849033780229;3976.224636195914;3977.3636218204947;7821.100573434128;7825.452218344662;7842.411819113589;7855.410844186709;7880.527168369917;7617.5048621839405;7671.654775535114;7674.309312161932;7680.923190768132;7703.075630924212;7791;7800.960995194988;7803.531788092619;7823.921760782319;7839.176886426957;7160.713571457083;7341;7381.889271661037;7382.630868456448;7414.036175297177;7191.280871912976;7213.639318033972;7236.38490728273;7241.674124664508;7256.455765817479;7469.439792015729;7728.8454230916195;7736.651850666621;7745.419093567893;7785.221477852169;3834.6932245419744;4564.201264778584;4591.747453890068;4750.928736068892;4759.714417134983;7394.260573942563;7410.333070023724;7419.888701669372;7431.40548756109;7448.813779655552;7195.956586295063;7198.460115491254;7203.8919416207755;7214.675339609626;7217.314355136254;6942.548734332252;7123.643817808985;7183.676734546853;7203.783886483414;7208.531445456028;6978.441724661913;7022.12223472066;7025.121859767529;7027.332403421667;7033.964830175816;5944;7041.943708443774;7159;7167.139943206848;7175.318344757448;5920.467157955804;6795.116634837637;6806.808808458401;7023.086998690138;7053.365197132282 23:25:32 INFO - PROCESS | 2367 | |5;yui.html;753.7663324369446;770.2143813310423;772.5596410046269;776.6543887969852;810.1331575214521;15236.542903712878;15341.23293835308;15518.456854010112;15571.065736055845;15598.532044038682;14345.784813227783;14427.278636068208;14429.855701442983;14444.927775361135;14472.059316144443;797.8763291689768;804.3766081286991;951.1439704266147;965.2567523007315;976.9462679552622;1002.013017178079;1004.4425343934114;1006.7080546641465;1007.8840933292655;1008.6620981971048;1045.8431235314688;1050.8423736439556;1051.0067985753467;1054.398992574233;1054.5043829400208;824.1840577827937;1020.7448137965508;1042.108996807726;1045.4511381524685;1047.1361127070122;777.7899967008932;779.0923574036241;780.5160800303792;780.5277806926841;781.3905153979905;14940.252987350588;15039.248037598185;15066;15082.170480623561;15082.472113475975;12861;13105.2136871788;13132.146410483288;13157.210567365988;13228.669283267898;10185.541650625739;10320.58717651293;10372.585096596127;10611.310264832839;10643.78712425755;3581.5881173665102;3591.712662986955;3620.294042661682;3678.098865777875;3842.4620553122586;78619.21380786176;79648.00879977988;79915;79999.60000199961;83127.5843620778;9507;9682.322237443452;9724.416535007922;9741.464219467856;9851.16265117473;21326.78673213248;21341.679874801892;21345.35963921085;21351.67972480414;21411.143554257655;7531.849363012709;7617.27635874591;7646.9617651911385;7647.158812530728;7819.882701759479;3457.481377793351;4127.9174416511505;4198.748075115503;4291.120320334324;4460.219461594208;3766;3776.678982286536;3795.5065841440987;3799.50606421169;3814.5231846019246;599.9610025348338;652.5073569455031;679.4394624434861;684.1072400517273;702.3152426384337;606.2149516376303;619.8109576579096;629.3894921925724;637.4804534304619;642.7557528139371;8034;8197.46716463428;8333.791655208668;8483.194096560817;8822;612.4948958758698;615.3477314047125;625.6183727925961;628.1143587541544;629.1789215074281;3633.636636336398;3843.327417701891;4009.0979529605606;4063.9796801015805;4189.287821070426;91976.6203506948;93807;93813;93929;94029.11941761126;75650.48699025989;75677.62161189159;77315.22684773081;77758;78438;70376.64811675908;71498.2850171502;72933;73560;74522.62738686381;7931.5637639930355;8116.918830811853;8142.796430089295;8203;8215;48453.5154648449;50726;50878;50910;51413.7429312851;66030.33969660242;68102.31897680959;72318;72750;72863.63568182125;11258.324500529667;11385.715357116138;11579.07367410622;11818.349990750592;11921.701957450787;12044;12082.939585302018;12246.387680615755;12261.877381226073;12984;11477.885221148015;11488.080953523866;11600.6519804406;11880.465379058136;11922.986546143675;10088.394696318244;11598.884011160118;12006.879931200576;12130.575429859913;12247.75504489923;11221.495032723711;11755.529778809094;11845.940770296438;11899.702507437383;11990.220635658654;7520.962395187989;9296.628134874529;9918.950405247928;9921.801563968536;9938.503074846374;9798.265130115127;9984.301098923297;9991.750206244902;9995.850062248926;10004 23:25:32 INFO - PROCESS | 2367 | __end_tp_report 23:25:32 INFO - PROCESS | 2367 | __start_cc_report 23:25:32 INFO - PROCESS | 2367 | _x_x_mozilla_cycle_collect,1171 23:25:32 INFO - PROCESS | 2367 | __end_cc_report 23:25:32 INFO - PROCESS | 2367 | __startTimestamp1467527132123__endTimestamp 23:25:32 INFO - PROCESS | 2367 | 23:25:32 INFO - PROCESS | 2367 | ------- Summary: start ------- 23:25:32 INFO - PROCESS | 2367 | Number of tests: 6 23:25:32 INFO - PROCESS | 2367 | 23:25:32 INFO - PROCESS | 2367 | [#0] dojo.html Cycles:165 Average:5870.03 Median:6148.29 stddev:648.89 (10.6%) stddev-sans-first:616.57 23:25:32 INFO - PROCESS | 2367 | Values: 3215.6 3516.1 3589.5 3610.2 3620.5 5907.2 5910.8 5912.0 5918.2 5940.1 5926.7 5952.9 5955.2 5958.4 5964.6 5227.3 5249.0 5267.2 5344.5 5394.5 5303.5 5319.0 5331.7 5335.2 5340.6 5281.7 5331.1 5332.7 5347.5 5370.9 5345.8 5368.2 5377.2 5385.4 5406.3 5160.0 5242.5 5298.7 5300.2 5319.8 5764.2 5785.0 5788.3 5815.3 5841.8 6301.7 6308.1 6310.2 6324.4 6349.9 6174.3 6268.8 6313.8 6318.4 6319.0 5029.2 6011.7 6072.8 6088.8 6107.1 6354.8 6389.0 6401.6 6408.2 6412.4 5030.4 6166.7 6326.9 6347.9 6348.7 6314.4 6321.1 6334.6 6336.0 6343.5 6280.0 6343.2 6355.8 6358.7 6373.1 6266.8 6282.2 6313.5 6340.7 6355.8 5001.9 5032.7 5036.4 5050.8 5051.8 4524.4 4529.6 4535.8 4573.9 4578.4 5867.5 5974.7 5979.6 5983.6 6030.6 6293.1 6317.8 6325.7 6332.6 6342.5 6011.8 6025.5 6027.6 6027.8 6050.7 5450.3 5511.8 5516.3 5539.4 5554.8 6446.6 6483.5 6499.9 6506.9 6511.4 6338.9 6339.9 6350.3 6354.6 6365.1 6314.8 6421.1 6459.4 6502.3 6502.4 6216.4 6334.9 6337.8 6376.5 6395.0 6308.4 6333.7 6337.5 6347.5 6359.7 5633.8 5928.5 6148.3 6306.3 6347.7 6274.6 6311.1 6313.0 6322.3 6329.7 6031.7 6146.8 6181.8 6198.9 6211.5 5084.8 5806.2 6221.6 6310.9 6343.0 6174.1 6192.7 6202.1 6206.7 6226.6 23:25:32 INFO - PROCESS | 2367 | 23:25:32 INFO - PROCESS | 2367 | [#1] ext.html Cycles:180 Average:60227.81 Median:3379.21 stddev:129486.26 (3831.9%) stddev-sans-first:129771.94 23:25:32 INFO - PROCESS | 2367 | Values: 535.2 543.8 560.2 598.8 604.9 32921.7 33548.5 33572.2 33585.0 33599.8 34902.7 41572.2 41891.0 42054.9 42071.6 9638.3 9834.1 9841.6 9856.1 9859.3 9014.9 9708.2 9826.3 9829.3 9831.4 11851.1 12074.1 12128.3 12132.5 12140.9 11874.3 11985.9 11992.6 12004.6 12005.9 11839.7 11959.8 11971.3 12016.6 12026.2 42785.7 42954.6 43023.6 43304.8 43315.0 3334.2 3373.2 3385.2 3393.1 3456.7 29086.9 29127.0 31068.7 31140.4 31412.4 2845.4 2855.1 2880.0 2900.0 2908.4 410418.0 410455.0 410584.0 411641.0 413791.0 38763.0 39221.0 39495.8 56391.0 70618.6 36659.9 36784.4 36859.3 36862.6 36919.9 16341.8 16525.9 16540.9 16568.2 16585.8 13757.4 13824.1 13846.9 13853.7 13853.9 7352.0 8051.9 8182.7 8566.4 8718.0 2995.8 3016.6 3499.9 3541.2 3561.3 993.4 1024.0 1031.3 1058.2 1066.4 30599.5 31490.8 31542.7 31715.4 32294.7 1167.3 1237.8 1255.0 1271.6 1271.9 15804.0 16032.2 16128.9 16325.7 16505.9 645157.0 649258.0 659296.7 659991.0 660996.0 64054.7 64847.7 64897.0 65196.7 65857.3 1381.4 1559.4 1572.4 1581.7 1634.0 29401.6 29837.6 29858.3 29992.9 30474.0 49641.8 49737.8 50265.2 50300.7 50327.0 320933.0 322204.0 323336.0 323551.0 324184.0 24954.3 28346.1 29062.4 29345.9 29551.1 43871.6 44150.0 44257.0 45275.8 45351.8 32286.9 33568.8 37186.6 38449.4 39429.6 37966.0 38258.9 38273.4 38586.8 39142.8 37773.6 38284.2 38377.2 38466.0 38595.0 32646.9 34195.0 34195.8 34498.3 34546.8 25198.6 25351.2 25563.9 25850.8 26000.9 23:25:32 INFO - PROCESS | 2367 | 23:25:32 INFO - PROCESS | 2367 | [#2] jquery.html Cycles:180 Average:35749.46 Median:13978.42 stddev:108531.78 (776.4%) stddev-sans-first:108803.80 23:25:32 INFO - PROCESS | 2367 | Values: 411.6 413.6 416.2 418.9 423.2 19213.8 20645.0 21058.2 21343.6 21389.9 20160.9 20362.5 21366.5 21386.6 21391.9 5855.7 5942.6 6236.0 6242.8 6243.8 5413.4 6009.7 6139.2 6173.4 6207.7 5950.7 6227.6 6228.9 6234.4 6255.7 5756.5 6145.5 6205.7 6219.1 6227.2 4831.0 6022.1 6036.7 6043.8 6072.4 18029.8 25674.4 26470.2 26479.3 26584.7 1887.9 2177.0 2195.3 2282.5 2734.4 8604.3 9757.0 9860.3 10112.6 10327.9 1652.9 1748.3 1765.5 1800.2 1801.2 68422.7 68520.7 72302.0 113938.0 120086.4 9589.0 11744.7 11837.5 11894.5 11975.9 15346.2 15430.4 15537.2 15572.7 15577.8 7726.0 9238.2 9297.2 9313.2 9333.0 9417.2 9425.5 9442.5 9446.8 9516.5 4682.3 4741.8 4757.5 4760.7 4807.6 1979.3 2005.5 2025.3 2033.4 2034.8 858.6 973.3 996.0 1029.0 1064.0 16893.0 20260.5 20263.6 20705.8 20877.4 969.5 980.0 1003.4 1024.2 1044.9 10751.9 11010.6 11058.5 11108.6 11279.9 620393.0 634377.0 669495.0 675328.0 679688.0 120467.0 121436.4 127335.4 129136.0 130740.0 1014.8 1031.0 1031.1 1035.2 1061.7 14614.5 17259.2 17977.2 18099.6 18271.7 48008.1 48545.8 53871.2 53901.7 55061.0 77435.0 77543.0 78173.8 78586.0 78725.2 8210.3 8211.9 8263.3 8350.5 8598.9 12538.5 12717.2 12745.9 12758.7 12788.9 7432.0 10934.7 10982.6 11216.2 11467.4 10766.7 10837.9 10929.8 11189.5 11217.6 9602.0 11256.6 11304.7 11328.9 11467.0 8103.0 8201.5 8261.0 8299.5 8463.8 10819.1 11027.6 11189.8 11199.6 11394.7 23:25:32 INFO - PROCESS | 2367 | 23:25:32 INFO - PROCESS | 2367 | [#3] mootools.html Cycles:180 Average:5736.27 Median:4902.96 stddev:3234.21 (66.0%) stddev-sans-first:3227.60 23:25:32 INFO - PROCESS | 2367 | Values: 1497.6 1628.0 1643.7 1890.5 2000.2 8146.5 8752.9 8871.3 8874.6 8908.0 8623.3 8836.9 8856.1 8861.6 8866.0 2477.6 2508.6 2510.3 2510.9 2511.7 2354.8 2408.3 2411.7 2419.2 2429.0 2453.1 2470.4 2530.2 2530.3 2531.8 2454.9 2490.9 2499.4 2502.0 2504.3 2440.7 2470.7 2478.4 2488.8 2504.6 8688.7 8897.4 8973.5 8999.1 9044.4 5395.9 5580.0 5583.4 5592.9 5612.6 3056.9 3621.8 3647.1 3694.9 3727.9 1064.3 1074.8 1079.8 1083.4 1084.1 12031.3 12095.4 12186.5 12254.4 12257.6 4011.3 4626.5 4750.8 4759.5 4770.7 9414.7 9422.6 9424.5 9424.5 9424.6 5436.6 5450.6 5468.9 5472.3 5499.0 4547.2 4693.8 4939.8 5022.5 5099.7 3821.9 3850.3 3860.4 3953.9 3974.5 1002.9 1176.7 1224.5 1238.2 1239.2 853.6 961.3 993.2 1001.6 1010.1 5904.9 5992.1 6044.3 6053.6 6260.7 456.9 474.7 476.0 479.1 482.4 3819.8 3873.2 3917.7 3990.9 4023.1 10700.5 11138.2 11148.0 11168.6 11170.7 10708.2 10851.7 10958.7 11006.6 11013.1 8545.3 8565.6 8572.7 8598.4 8636.4 5591.6 5826.8 5834.0 5910.3 5930.3 9689.1 9808.6 9881.9 9998.4 10049.7 10002.2 10007.4 10071.0 10293.5 10338.7 6398.9 6562.4 6579.7 7089.0 7175.8 7691.6 8064.0 8439.2 8441.5 8494.7 7305.5 7437.9 7533.0 7632.5 7678.8 7101.6 7230.5 7262.7 7306.0 7332.4 6577.9 6598.2 6657.0 6667.3 6682.9 4886.8 4919.1 4923.5 5002.9 5006.9 4922.0 4965.0 5068.8 5076.3 5251.4 23:25:32 INFO - PROCESS | 2367 | 23:25:32 INFO - PROCESS | 2367 | [#4] prototype.html Cycles:180 Average:5820.87 Median:6723.58 stddev:1884.77 (28.0%) stddev-sans-first:1844.34 23:25:32 INFO - PROCESS | 2367 | Values: 323.5 326.1 338.2 340.5 340.7 6494.8 6695.3 6709.5 6735.9 6833.1 5361.8 6647.7 6717.1 6743.9 6795.9 4998.1 5009.7 5012.3 5021.7 5022.8 4073.3 5021.0 5025.2 5037.1 5056.2 4957.1 4961.0 4973.5 4974.3 4994.8 4970.3 4975.0 4987.7 4995.2 5001.6 3705.0 3974.3 4103.1 4117.4 4136.0 5818.5 6349.8 6441.1 6457.6 6478.5 4632.9 5724.3 5739.7 5746.4 5748.7 5678.8 7114.5 7121.6 7133.6 7135.0 4622.1 4631.1 4641.3 4642.1 4649.3 7153.2 7250.6 7431.8 7534.2 7556.5 4551.3 4613.2 4618.7 4620.3 4707.4 4741.4 4774.6 4785.5 4790.8 4811.7 4766.6 5392.7 5696.8 5703.6 5707.6 7126.6 7131.4 7142.5 7144.6 7153.0 1618.7 1649.6 1652.6 1654.4 1654.7 1034.7 1039.8 1059.7 1065.0 1068.9 5438.7 6730.1 6784.5 6788.9 6820.1 5985.5 7445.4 7450.8 7467.7 7471.6 6767.6 6781.6 6786.5 6790.2 6796.9 3796.8 3923.6 3968.8 3976.2 3977.4 7821.1 7825.5 7842.4 7855.4 7880.5 7617.5 7671.7 7674.3 7680.9 7703.1 7791.0 7801.0 7803.5 7823.9 7839.2 7160.7 7341.0 7381.9 7382.6 7414.0 7191.3 7213.6 7236.4 7241.7 7256.5 7469.4 7728.8 7736.7 7745.4 7785.2 3834.7 4564.2 4591.7 4750.9 4759.7 7394.3 7410.3 7419.9 7431.4 7448.8 7196.0 7198.5 7203.9 7214.7 7217.3 6942.5 7123.6 7183.7 7203.8 7208.5 6978.4 7022.1 7025.1 7027.3 7034.0 5944.0 7041.9 7159.0 7167.1 7175.3 5920.5 6795.1 6806.8 7023.1 7053.4 23:25:32 INFO - PROCESS | 2367 | 23:25:32 INFO - PROCESS | 2367 | [#5] yui.html Cycles:180 Average:18583.55 Median:49589.76 stddev:25953.72 (52.3%) stddev-sans-first:25992.00 23:25:32 INFO - PROCESS | 2367 | Values: 753.8 770.2 772.6 776.7 810.1 15236.5 15341.2 15518.5 15571.1 15598.5 14345.8 14427.3 14429.9 14444.9 14472.1 797.9 804.4 951.1 965.3 976.9 1002.0 1004.4 1006.7 1007.9 1008.7 1045.8 1050.8 1051.0 1054.4 1054.5 824.2 1020.7 1042.1 1045.5 1047.1 777.8 779.1 780.5 780.5 781.4 14940.3 15039.2 15066.0 15082.2 15082.5 12861.0 13105.2 13132.1 13157.2 13228.7 10185.5 10320.6 10372.6 10611.3 10643.8 3581.6 3591.7 3620.3 3678.1 3842.5 78619.2 79648.0 79915.0 79999.6 83127.6 9507.0 9682.3 9724.4 9741.5 9851.2 21326.8 21341.7 21345.4 21351.7 21411.1 7531.8 7617.3 7647.0 7647.2 7819.9 3457.5 4127.9 4198.7 4291.1 4460.2 3766.0 3776.7 3795.5 3799.5 3814.5 600.0 652.5 679.4 684.1 702.3 606.2 619.8 629.4 637.5 642.8 8034.0 8197.5 8333.8 8483.2 8822.0 612.5 615.3 625.6 628.1 629.2 3633.6 3843.3 4009.1 4064.0 4189.3 91976.6 93807.0 93813.0 93929.0 94029.1 75650.5 75677.6 77315.2 77758.0 78438.0 70376.6 71498.3 72933.0 73560.0 74522.6 7931.6 8116.9 8142.8 8203.0 8215.0 48453.5 50726.0 50878.0 50910.0 51413.7 66030.3 68102.3 72318.0 72750.0 72863.6 11258.3 11385.7 11579.1 11818.3 11921.7 12044.0 12082.9 12246.4 12261.9 12984.0 11477.9 11488.1 11600.7 11880.5 11923.0 10088.4 11598.9 12006.9 12130.6 12247.8 11221.5 11755.5 11845.9 11899.7 11990.2 7521.0 9296.6 9919.0 9921.8 9938.5 9798.3 9984.3 9991.8 9995.9 10004.0 23:25:32 INFO - PROCESS | 2367 | -------- Summary: end -------- 23:25:32 INFO - PROCESS | 2367 | 23:25:32 INFO - TEST-INFO | 2367: exit 0 23:25:32 INFO - TEST-OK | dromaeo_css | took 1112556ms 23:25:32 INFO - TEST-START | kraken 23:25:32 INFO - operating with platform_type : mac_ 23:25:32 INFO - Initialising browser for kraken test... 23:25:32 INFO - TEST-INFO | started process 2369 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmpvPy3kX/profile http://localhost:51035/getInfo.html) 23:25:34 INFO - PROCESS | 2369 | __metrics Screen width/height:1600/1200 23:25:34 INFO - PROCESS | 2369 | colorDepth:24 23:25:34 INFO - PROCESS | 2369 | Browser inner width/height: 1024/689 23:25:34 INFO - PROCESS | 2369 | __metrics 23:25:34 INFO - PROCESS | 2369 | 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" 23:25:34 ERROR - PROCESS | 2369 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:25:35 INFO - TEST-INFO | 2369: exit 0 23:25:35 INFO - Browser initialized. 23:25:35 INFO - Running cycle 1/1 for kraken test... 23:25:35 INFO - TEST-INFO | started process 2372 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmpvPy3kX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:47 INFO - PROCESS | 2372 | RSS: Main: 161447936 23:25:47 INFO - PROCESS | 2372 | 23:25:49 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51035/tests/kraken/driver.html?testName=audio-beat-detection) 23:25:50 INFO - PROCESS | 2372 | RSS: Main: 223952896 23:25:50 INFO - PROCESS | 2372 | 23:25:53 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51035/tests/kraken/driver.html?testName=audio-dft) 23:25:54 INFO - PROCESS | 2372 | RSS: Main: 240320512 23:25:54 INFO - PROCESS | 2372 | 23:25:57 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51035/tests/kraken/driver.html?testName=audio-fft) 23:25:57 INFO - PROCESS | 2372 | RSS: Main: 325382144 23:25:57 INFO - PROCESS | 2372 | 23:25:59 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51035/tests/kraken/driver.html?testName=audio-oscillator) 23:26:00 INFO - PROCESS | 2372 | RSS: Main: 231297024 23:26:00 INFO - PROCESS | 2372 | 23:26:02 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51035/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:26:03 INFO - PROCESS | 2372 | RSS: Main: 232181760 23:26:03 INFO - PROCESS | 2372 | 23:26:05 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51035/tests/kraken/driver.html?testName=imaging-darkroom) 23:26:06 INFO - PROCESS | 2372 | RSS: Main: 269426688 23:26:06 INFO - PROCESS | 2372 | 23:26:09 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51035/tests/kraken/driver.html?testName=imaging-desaturate) 23:26:09 INFO - PROCESS | 2372 | RSS: Main: 270323712 23:26:09 INFO - PROCESS | 2372 | 23:26:12 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51035/tests/kraken/driver.html?testName=json-parse-financial) 23:26:13 INFO - PROCESS | 2372 | RSS: Main: 269963264 23:26:13 INFO - PROCESS | 2372 | 23:26:14 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51035/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:26:15 INFO - PROCESS | 2372 | RSS: Main: 260616192 23:26:15 INFO - PROCESS | 2372 | 23:26:17 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51035/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:26:17 INFO - PROCESS | 2372 | RSS: Main: 267669504 23:26:17 INFO - PROCESS | 2372 | 23:26:19 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51035/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:26:20 INFO - PROCESS | 2372 | RSS: Main: 270970880 23:26:20 INFO - PROCESS | 2372 | 23:26:23 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:23 INFO - PROCESS | 2372 | RSS: Main: 278777856 23:26:23 INFO - PROCESS | 2372 | 23:26:26 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:27 INFO - PROCESS | 2372 | RSS: Main: 275308544 23:26:27 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51035/tests/kraken/driver.html?testName=ai-astar) 23:26:29 INFO - PROCESS | 2372 | RSS: Main: 336195584 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | __start_tp_report 23:26:29 INFO - PROCESS | 2372 | _x_x_mozilla_page_load 23:26:29 INFO - PROCESS | 2372 | _x_x_mozilla_page_load_details 23:26:29 INFO - PROCESS | 2372 | |i|pagename|runs| 23:26:29 INFO - PROCESS | 2372 | |0;ai-astar;114;112;118;111;112;113;112;113;115;132 23:26:29 INFO - PROCESS | 2372 | |1;audio-beat-detection;179;128;143;165;120;138;117;153;154;119 23:26:29 INFO - PROCESS | 2372 | |2;audio-dft;185;190;186;184;185;185;187;185;182;185 23:26:29 INFO - PROCESS | 2372 | |3;audio-fft;74;78;73;153;55;55;57;64;134;83 23:26:29 INFO - PROCESS | 2372 | |4;audio-oscillator;93;88;144;79;84;90;124;80;76;127 23:26:29 INFO - PROCESS | 2372 | |5;imaging-gaussian-blur;89;86;89;86;88;87;89;86;89;84 23:26:29 INFO - PROCESS | 2372 | |6;imaging-darkroom;93;94;93;100;139;94;95;96;94;95 23:26:29 INFO - PROCESS | 2372 | |7;imaging-desaturate;83;83;84;84;84;84;84;86;84;85 23:26:29 INFO - PROCESS | 2372 | |8;json-parse-financial;58;60;60;87;97;89;62;76;58;55 23:26:29 INFO - PROCESS | 2372 | |9;json-stringify-tinderbox;65;62;71;66;76;72;68;68;67;68 23:26:29 INFO - PROCESS | 2372 | |10;stanford-crypto-aes;79;79;79;78;79;79;80;77;89;103 23:26:29 INFO - PROCESS | 2372 | |11;stanford-crypto-ccm;127;123;124;125;123;126;120;134;147;137 23:26:29 INFO - PROCESS | 2372 | |12;stanford-crypto-pbkdf2;162;161;163;163;161;200;218;165;161;161 23:26:29 INFO - PROCESS | 2372 | |13;stanford-crypto-sha256-iterative;65;70;85;93;96;95;70;67;67;66 23:26:29 INFO - PROCESS | 2372 | __end_tp_report 23:26:29 INFO - PROCESS | 2372 | __start_cc_report 23:26:29 INFO - PROCESS | 2372 | _x_x_mozilla_cycle_collect,1875 23:26:29 INFO - PROCESS | 2372 | __end_cc_report 23:26:29 INFO - PROCESS | 2372 | __startTimestamp1467527189484__endTimestamp 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | ------- Summary: start ------- 23:26:29 INFO - PROCESS | 2372 | Number of tests: 14 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#0] ai-astar Cycles:10 Average:115.20 Median:113.50 stddev:6.23 (5.5%) stddev-sans-first:6.60 23:26:29 INFO - PROCESS | 2372 | Values: 114.0 112.0 118.0 111.0 112.0 113.0 112.0 113.0 115.0 132.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:148.00 stddev:21.11 (14.3%) stddev-sans-first:17.53 23:26:29 INFO - PROCESS | 2372 | Values: 179.0 128.0 143.0 165.0 120.0 138.0 117.0 153.0 154.0 119.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#2] audio-dft Cycles:10 Average:185.40 Median:185.00 stddev:2.07 (1.1%) stddev-sans-first:2.19 23:26:29 INFO - PROCESS | 2372 | Values: 185.0 190.0 186.0 184.0 185.0 185.0 187.0 185.0 182.0 185.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#3] audio-fft Cycles:10 Average:82.60 Median:68.50 stddev:33.85 (49.4%) stddev-sans-first:35.76 23:26:29 INFO - PROCESS | 2372 | Values: 74.0 78.0 73.0 153.0 55.0 55.0 57.0 64.0 134.0 83.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:82.00 stddev:24.00 (29.3%) stddev-sans-first:25.37 23:26:29 INFO - PROCESS | 2372 | Values: 93.0 88.0 144.0 79.0 84.0 90.0 124.0 80.0 76.0 127.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.50 stddev:1.77 (2.0%) stddev-sans-first:1.76 23:26:29 INFO - PROCESS | 2372 | Values: 89.0 86.0 89.0 86.0 88.0 87.0 89.0 86.0 89.0 84.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:94.00 stddev:14.10 (15.0%) stddev-sans-first:14.76 23:26:29 INFO - PROCESS | 2372 | Values: 93.0 94.0 93.0 100.0 139.0 94.0 95.0 96.0 94.0 95.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.88 (1.0%) stddev-sans-first:0.83 23:26:29 INFO - PROCESS | 2372 | Values: 83.0 83.0 84.0 84.0 84.0 84.0 84.0 86.0 84.0 85.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#8] json-parse-financial Cycles:10 Average:70.20 Median:69.00 stddev:15.60 (22.6%) stddev-sans-first:15.91 23:26:29 INFO - PROCESS | 2372 | Values: 58.0 60.0 60.0 87.0 97.0 89.0 62.0 76.0 58.0 55.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:3.92 (5.8%) stddev-sans-first:3.97 23:26:29 INFO - PROCESS | 2372 | Values: 65.0 62.0 71.0 66.0 76.0 72.0 68.0 68.0 67.0 68.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:79.00 stddev:8.02 (10.2%) stddev-sans-first:8.43 23:26:29 INFO - PROCESS | 2372 | Values: 79.0 79.0 79.0 78.0 79.0 79.0 80.0 77.0 89.0 103.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:126.50 stddev:8.29 (6.6%) stddev-sans-first:8.77 23:26:29 INFO - PROCESS | 2372 | Values: 127.0 123.0 124.0 125.0 123.0 126.0 120.0 134.0 147.0 137.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:163.00 stddev:20.26 (12.4%) stddev-sans-first:21.19 23:26:29 INFO - PROCESS | 2372 | Values: 162.0 161.0 163.0 163.0 161.0 200.0 218.0 165.0 161.0 161.0 23:26:29 INFO - PROCESS | 2372 | 23:26:29 INFO - PROCESS | 2372 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:77.50 stddev:13.19 (17.0%) stddev-sans-first:13.21 23:26:29 INFO - PROCESS | 2372 | Values: 65.0 70.0 85.0 93.0 96.0 95.0 70.0 67.0 67.0 66.0 23:26:29 INFO - PROCESS | 2372 | -------- Summary: end -------- 23:26:29 INFO - PROCESS | 2372 | 23:26:30 INFO - TEST-INFO | 2372: exit 0 23:26:30 INFO - TEST-OK | kraken | took 57659ms 23:26:30 INFO - SUITE-END | took 1170s 23:26:30 INFO - Completed test suite (00:19:30) 23:26:30 INFO - javascript benchmark 23:26:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3215.64627890932, 3516.138546056216, 3589.5154154189177, 3610.169660977974, 3620.5293311869455, 5907.232059832221, 5910.822675319747, 5911.970440147804, 5918.171455996153, 5940.108983652449, 5926.674032928187, 5952.88094238115, 5955.225820643311, 5958.404159584039, 5964.612300200495, 5227.294315267447, 5248.973755131219, 5267.157254839227, 5344.518993290603, 5394.487523685244, 5303.522682958533, 5318.973405132969, 5331.706756128411, 5335.173048177519, 5340.599455040868, 5281.683099014072, 5331.120365139747, 5332.733363331838, 5347.491988261109, 5370.91943620846, 5345.812896548621, 5368.221607866876, 5377.247185394048, 5385.353757549119, 5406.324209473816, 5159.993801208766, 5242.501962313574, 5298.655587386807, 5300.204969254604, 5319.813806516753, 5764.193012978187, 5785.0, 5788.305403351583, 5815.273090863642, 5841.824745257649, 6301.684915754194, 6308.053791931247, 6310.242770867525, 6324.367563243685, 6349.904751428732, 6174.289956654952, 6268.843278918018, 6313.842153946142, 6318.368163183645, 6319.020551814476, 5029.245613158056, 6011.729472173719, 6072.817815465543, 6088.756449742049, 6107.083937409424, 6354.809355719336, 6389.041643753474, 6401.58389704677, 6408.198975128109, 6412.39082287182, 5030.37120359955, 6166.691665416801, 6326.905096423558, 6347.936520634827, 6348.746050157942, 6314.400131987454, 6321.146645202931, 6334.5565810393755, 6335.968320158462, 6343.460805831556, 6279.995200767855, 6343.175387199634, 6355.809325720235, 6358.745650173942, 6373.075903993895, 6266.780662676784, 6282.151909492251, 6313.463355614824, 6340.682965851689, 6355.777547785805, 5001.89996200074, 5032.72320022395, 5036.370453693288, 5050.772715227824, 5051.848444546669, 4524.366588677522, 4529.614982726505, 4535.750533720611, 4573.931391029138, 4578.381918440968, 5867.471927526543, 5974.701264936736, 5979.5814292999075, 5983.640981541122, 6030.577859549877, 6293.087502312139, 6317.778877739349, 6325.683715814191, 6332.588381755171, 6342.4926005919415, 6011.7595296187665, 6025.548083893726, 6027.60820546663, 6027.78902738402, 6050.667213303311, 5450.264214331015, 5511.834644960658, 5516.3380394352935, 5539.362973258127, 5554.750036248379, 6446.645434501053, 6483.481321494363, 6499.935000650122, 6506.934930650633, 6511.446527045159, 6338.8732225354315, 6339.922213223671, 6350.269718982377, 6354.555181137276, 6365.108884756045, 6314.842128946813, 6421.101045853491, 6459.418652321314, 6502.284748677736, 6502.447291980235, 6216.44052035319, 6334.90497642545, 6337.7781777637565, 6376.52176086786, 6394.97680371157, 6308.369163083655, 6333.65164915934, 6337.4613157882095, 6347.460465860454, 6359.650219237987, 5633.802816901389, 5928.4960778334325, 6148.292946311231, 6306.337834527492, 6347.71435285404, 6274.560780745304, 6311.116443697794, 6313.0, 6322.272938612118, 6329.715162817776, 6031.668258245839, 6146.78486252979, 6181.783637572664, 6198.938010620016, 6211.472024877936, 5084.847454576368, 5806.216160818235, 6221.564490485623, 6310.873782524415, 6343.0485427186295, 6174.073888916699, 6192.721327540362, 6202.069689546604, 6206.658633775186, 6226.5641405101205], "value": 5830.139283736798, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.210564417484, 543.7906406033677, 560.2017125596025, 598.814367546061, 604.9122877182808, 32921.67078329216, 33548.49677254843, 33572.16069598261, 33585.0, 33599.83200083999, 34902.65097349026, 41572.16855662885, 41890.95272618186, 42054.94862628436, 42071.579284207226, 9638.325317227815, 9834.114929656329, 9841.606335746561, 9856.112949834513, 9859.260555458333, 9014.909850901473, 9708.174805141536, 9826.263030272723, 9829.262805289596, 9831.410115393099, 11851.111166662491, 12074.094442916816, 12128.272303661764, 12132.454039568196, 12140.878591214107, 11874.28754274742, 11985.940070299594, 11992.64022079339, 12004.639860804189, 12005.939970300136, 11839.704007399798, 11959.760804783855, 11971.281723096643, 12016.63950081499, 12026.15816892818, 42785.71642850719, 42954.57045429537, 43023.56976430227, 43304.78347608273, 43315.0, 3334.2497937963763, 3373.207296285371, 3385.2044769479153, 3393.100828280508, 3456.6716161964573, 29086.854565727037, 29127.0, 31068.689313107032, 31140.377192456024, 31412.37175256482, 2845.416689578652, 2855.0721015669783, 2879.956800647992, 2899.9710002900124, 2908.403777225664, 410418.0, 410455.0, 410584.0, 411641.0, 413791.0, 38763.0, 39221.0, 39495.802520987214, 56391.0, 70618.64690676513, 36659.90020299395, 36784.448233276526, 36859.26281474355, 36862.631373686454, 36919.89240322741, 16341.754873676904, 16525.91737041307, 16540.91729541369, 16568.17159142038, 16585.83414165843, 13757.38091785852, 13824.101433406797, 13846.861531384759, 13853.722925541635, 13853.930730346485, 7351.963240183765, 8051.879221811678, 8182.713605023796, 8566.400351975302, 8717.953845538575, 2995.7902946793515, 3016.638003439601, 3499.9300013999577, 3541.220931395089, 3561.3411518869093, 993.4138858073627, 1023.959041638341, 1031.2677998620914, 1058.1534772182224, 1066.3814987307344, 30599.455176075135, 31490.842545787124, 31542.684573154434, 31715.36569268648, 32294.677053229167, 1167.2821214952912, 1237.8205160251894, 1254.9749005019848, 1271.6375832887582, 1271.8918891894107, 15804.0, 16032.19839008045, 16128.870979031355, 16325.67348653044, 16505.917470412573, 645157.0, 649258.0, 659296.7035164793, 659991.0, 660996.0, 64054.67972660107, 64847.67576162089, 64897.0, 65196.674016629615, 65857.34142658608, 1381.412899517701, 1559.4308077551611, 1572.4024870549117, 1581.675756469921, 1634.0277534866734, 29401.55897661494, 29837.5524367139, 29858.253543661584, 29992.85003574968, 30474.0, 49641.751791242255, 49737.75131124321, 50265.24602131044, 50300.748496257285, 50326.99346013132, 320933.0, 322204.0, 323336.0, 323551.0, 324184.0, 24954.251372458857, 28346.149615511567, 29062.41875162527, 29345.85327073351, 29551.113466595176, 43871.56128438802, 44150.0, 44257.0, 45275.77362113168, 45351.77324113358, 32286.869959551303, 33568.83215583907, 37186.6281337194, 38449.42325865058, 39429.61996330115, 37966.0, 38258.85223443301, 38273.4258986121, 38586.807065965615, 39142.80428597839, 37773.62226377811, 38284.234315312984, 38377.232455350175, 38466.0383490415, 38595.0, 32646.878565769723, 34194.97415077552, 34195.82902085473, 34498.31003379969, 34546.827265864515, 25198.62202067007, 25351.239462816146, 25563.872180638977, 25850.836712347613, 26000.8699956499], "value": 18901.724382746306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.56785375355867, 413.5946772163282, 416.2299745470879, 418.9099343641117, 423.1600273457189, 19213.807861921377, 20645.0, 21058.157673693033, 21343.57312853742, 21389.893050534763, 20160.899195504004, 20362.490937726565, 21366.465838354048, 21386.57226855462, 21391.893040534775, 5855.707214639262, 5942.584019118642, 6236.0, 6242.781502647408, 6243.781467648633, 5413.377461591908, 6009.729562169691, 6139.2325959255095, 6173.413525715072, 6207.720652570622, 5950.732217050221, 6227.595206311598, 6228.875422491547, 6234.407731265523, 6255.687215639223, 5756.539476841885, 6145.477634401082, 6205.658688772116, 6219.129321894893, 6227.221597300338, 4831.033793241366, 6022.126791615235, 6036.698165091728, 6043.848903777397, 6072.392760723937, 18029.82806117598, 25674.358141046436, 26470.205893823215, 26479.338016549547, 26584.73415265842, 1887.867849250553, 2177.031221106608, 2195.3413975807352, 2282.4864405508793, 2734.4257705881787, 8604.31165506758, 9756.95121524395, 9860.260480463921, 10112.646057387956, 10327.948360258226, 1652.8512433881008, 1748.3443708609273, 1765.5497848048665, 1800.189914538463, 1801.1714611278828, 68422.65788671075, 68520.6573967132, 72302.0, 113938.0, 120086.39956800247, 9589.0, 11744.70638234051, 11837.526498939946, 11894.524219031315, 11975.880241197476, 15346.232688365537, 15430.38278468871, 15537.223138843012, 15572.688546229012, 15577.766333505006, 7726.0342457192855, 9238.214751746042, 9297.163255307054, 9313.161815436642, 9332.953335233417, 9417.199538039207, 9425.528723563795, 9442.48066356357, 9446.763830904283, 9516.476593787409, 4682.321063445781, 4741.810327586927, 4757.524247575215, 4760.714357138583, 4807.5817633798115, 1979.2676709617533, 2005.5186755178652, 2025.3215172917237, 2033.3696554068285, 2034.7660019097698, 858.553337626102, 973.2894986659778, 995.9800803983879, 1028.9897101028894, 1064.0211005874614, 16893.0, 20260.493487662927, 20263.594728105356, 20705.792942070686, 20877.37367878966, 969.539468752337, 979.9657012004545, 1003.3879333606494, 1024.2267088348249, 1044.9216308776872, 10751.892481075089, 11010.614628487965, 11058.502367393487, 11108.55565777376, 11279.887201128047, 620393.0, 634377.0, 669495.0, 675328.0, 679688.0, 120467.0, 121436.39281803711, 127335.36332318465, 129136.0, 130740.0, 1014.8477728340808, 1030.953607087683, 1031.118393773328, 1035.2184101003695, 1061.6868023932805, 14614.488492902698, 17259.22333495021, 17977.191026403583, 18099.63800723952, 18271.725924111415, 48008.07967681254, 48545.7863553414, 53871.19193212183, 53901.65245868728, 55061.0, 77435.0, 77543.0, 78173.82739258802, 78586.0, 78725.21274787179, 8210.302124319262, 8211.917880821355, 8263.338932885235, 8350.540720260444, 8598.914010860062, 12538.498460061495, 12717.173383730027, 12745.916597089352, 12758.744825103631, 12788.936055320037, 7431.962840185764, 10934.671959841218, 10982.560697572007, 11216.2148649597, 11467.426628668367, 10766.67699968971, 10837.891621084003, 10929.83605245906, 11189.496472658913, 11217.607383741857, 9601.951990240004, 11256.606018789304, 11304.717382065186, 11328.886711132784, 11467.025302849352, 8103.0, 8201.548914809742, 8261.008678958564, 8299.460535065202, 8463.788405289917, 10819.1344692426, 11027.558897644005, 11189.832152517556, 11199.552017919517, 11394.715132121763], "value": 9650.179361574266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.6255936015996, 1627.967440651187, 1643.7123503386904, 1890.4990177602938, 2000.159932828212, 8146.511209327437, 8752.91247087529, 8871.290296776258, 8874.645014199425, 8908.0, 8623.267022303111, 8836.8674469883, 8856.11438856114, 8861.601227944742, 8866.02473727891, 2477.55404027275, 2508.623706444039, 2510.3222130024883, 2510.9372265693323, 2511.6985961684622, 2354.799842013431, 2408.349745568695, 2411.7105947286263, 2419.2258477287187, 2428.963565546518, 2453.0678342229926, 2470.3700556358103, 2530.1903390914913, 2530.291518374858, 2531.835430697008, 2454.8649824259746, 2490.8754562271906, 2499.4001439654535, 2501.987490062538, 2504.261242933339, 2440.707115146176, 2470.7035155781423, 2478.3927937655208, 2488.8133389995824, 2504.586743187372, 8688.739337819876, 8897.377183597151, 8973.461592304417, 8999.055099214555, 9044.41211321262, 5395.865103372408, 5580.0, 5583.441655834384, 5592.944070559283, 5612.607117501777, 3056.923576910595, 3621.764585301947, 3647.1246900743895, 3694.8891533254045, 3727.9068023299365, 1064.302881612545, 1074.785042991405, 1079.838024296354, 1083.3716444462273, 1084.1001968366238, 12031.27812331263, 12095.39523023854, 12186.451609677497, 12254.387280636021, 12257.57098501557, 4011.338129208648, 4626.4910859805395, 4750.8337208197545, 4759.50025247351, 4770.689905156154, 9414.717558473258, 9422.623095076257, 9424.481653508985, 9424.481653509123, 9424.575894084783, 5436.565074794007, 5450.645708028966, 5468.890622187534, 5472.315960504937, 5498.972505137449, 4547.226971414867, 4693.83571575, 4939.753012349368, 5022.497750225021, 5099.6685215460875, 3821.8662346817728, 3850.268448994682, 3860.401637746154, 3953.9011524711536, 3974.503187101612, 1002.8796544414571, 1176.7175877789268, 1224.4979558381021, 1238.1642391385958, 1239.1573729863599, 853.6158728572167, 961.2550273538064, 993.2352088891513, 1001.5593139018808, 1010.0858722855827, 5904.881902361929, 5992.0712289595185, 6044.335123136451, 6053.636781793107, 6260.686965651699, 456.8766433063054, 474.6772194907496, 475.9932742250116, 479.1160309229466, 482.4042307749926, 3819.8090095495113, 3873.2447172801035, 3917.6865850731874, 3990.9002274942777, 4023.054582173187, 10700.518476668569, 11138.164637652208, 11148.0, 11168.553257869757, 11170.720731981766, 10708.19688523364, 10851.728706782395, 10958.671239862817, 11006.614768483225, 11013.118950483942, 8545.273651739672, 8565.571721413904, 8572.742817715478, 8598.441101328393, 8636.352273579507, 5591.552675785846, 5826.766929322949, 5834.0, 5910.290765108042, 5930.288365396007, 9689.12797848197, 9808.607655693977, 9881.901180988385, 9998.350107243006, 10049.69850904474, 10002.199824014207, 10007.399556026661, 10071.0, 10293.485325733534, 10338.741531461774, 6398.87202255943, 6562.409383155539, 6579.736810527525, 7089.042979197742, 7175.820604484721, 7691.5769632670745, 8063.959680201561, 8439.156084391758, 8441.451305665112, 8494.660213591387, 7305.525140865827, 7437.888431673638, 7532.962335188289, 7632.542047477169, 7678.808029799076, 7101.609411482212, 7230.45771567124, 7262.745803896838, 7305.963470182615, 7332.376747976482, 6577.901331480128, 6598.241202261609, 6656.966715166393, 6667.333266673294, 6682.899756503753, 4886.828960986349, 4919.0899683558655, 4923.532264434873, 5002.87492812668, 5006.899862002667, 4922.040202160544, 4964.975175124101, 5068.847934561969, 5076.289319495199, 5251.36983561975], "value": 4551.808209135916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.4856578040916, 326.07882731284116, 338.1748533578069, 340.51986698754763, 340.6746557038029, 6494.772682956098, 6695.296993815647, 6709.496787740921, 6735.865282694349, 6833.145856767904, 5361.839144825662, 6647.734090636369, 6717.059611654372, 6743.865122697555, 6795.932040679591, 4998.100341938459, 5009.749512524378, 5012.298278241049, 5021.748912554376, 5022.799088036492, 4073.307537718595, 5021.046001259767, 5025.246213068051, 5037.143685573443, 5056.241563765446, 4957.082939656157, 4961.007798440309, 4973.52751488608, 4974.278729584208, 4994.800207991676, 4970.254461830718, 4974.9751251243515, 4987.650864439473, 4995.225740010304, 5001.624878134136, 3705.0366904604725, 3974.284628766821, 4103.076807718269, 4117.3618089195925, 4135.958640413587, 5818.505427038707, 6349.777757778502, 6441.130447389589, 6457.580257283262, 6478.481721462272, 4632.884177895546, 5724.313082430135, 5739.655620662732, 5746.396628354005, 5748.741306641211, 5678.772849086032, 7114.501984861062, 7121.608311542915, 7133.607651579161, 7134.964325178393, 4622.075584883003, 4631.120087183424, 4641.280601506772, 4642.0715856828765, 4649.279361698942, 7153.177384600734, 7250.637468126625, 7431.814204644819, 7534.171241163468, 7556.546607203585, 4551.271796512542, 4613.169629466728, 4618.699784513996, 4620.330052142421, 4707.435107787019, 4741.407324084489, 4774.641901857305, 4785.545373189541, 4790.760461976887, 4811.663183577116, 4766.571008609242, 5392.73036348181, 5696.8006119785605, 5703.572232082611, 5707.600467967202, 7126.643667816588, 7131.358177764027, 7142.535735177197, 7144.571325720473, 7153.0, 1618.6600813828993, 1649.554620252549, 1652.5703317137632, 1654.3796076471324, 1654.6525229701656, 1034.6637342863598, 1039.77644806367, 1059.7244716373798, 1064.973375665599, 1068.8663917010374, 5438.7280635968045, 6730.091437655951, 6784.457243420613, 6788.879834827297, 6820.079289295882, 5985.521158307325, 7445.441591880631, 7450.813729656694, 7467.738629147953, 7471.626418679044, 6767.593944363354, 6781.62701051437, 6786.491013174032, 6790.1851777786, 6796.898046529306, 3796.8291426885858, 3923.5684074751753, 3968.849033780229, 3976.224636195914, 3977.3636218204947, 7821.100573434128, 7825.452218344662, 7842.411819113589, 7855.410844186709, 7880.527168369917, 7617.5048621839405, 7671.654775535114, 7674.309312161932, 7680.923190768132, 7703.075630924212, 7791.0, 7800.960995194988, 7803.531788092619, 7823.921760782319, 7839.176886426957, 7160.713571457083, 7341.0, 7381.889271661037, 7382.630868456448, 7414.036175297177, 7191.280871912976, 7213.639318033972, 7236.38490728273, 7241.674124664508, 7256.455765817479, 7469.439792015729, 7728.8454230916195, 7736.651850666621, 7745.419093567893, 7785.221477852169, 3834.6932245419744, 4564.201264778584, 4591.747453890068, 4750.928736068892, 4759.714417134983, 7394.260573942563, 7410.333070023724, 7419.888701669372, 7431.40548756109, 7448.813779655552, 7195.956586295063, 7198.460115491254, 7203.8919416207755, 7214.675339609626, 7217.314355136254, 6942.548734332252, 7123.643817808985, 7183.676734546853, 7203.783886483414, 7208.531445456028, 6978.441724661913, 7022.12223472066, 7025.121859767529, 7027.332403421667, 7033.964830175816, 5944.0, 7041.943708443774, 7159.0, 7167.139943206848, 7175.318344757448, 5920.467157955804, 6795.116634837637, 6806.808808458401, 7023.086998690138, 7053.365197132282], "value": 5191.920162484332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.7663324369446, 770.2143813310423, 772.5596410046269, 776.6543887969852, 810.1331575214521, 15236.542903712878, 15341.23293835308, 15518.456854010112, 15571.065736055845, 15598.532044038682, 14345.784813227783, 14427.278636068208, 14429.855701442983, 14444.927775361135, 14472.059316144443, 797.8763291689768, 804.3766081286991, 951.1439704266147, 965.2567523007315, 976.9462679552622, 1002.013017178079, 1004.4425343934114, 1006.7080546641465, 1007.8840933292655, 1008.6620981971048, 1045.8431235314688, 1050.8423736439556, 1051.0067985753467, 1054.398992574233, 1054.5043829400208, 824.1840577827937, 1020.7448137965508, 1042.108996807726, 1045.4511381524685, 1047.1361127070122, 777.7899967008932, 779.0923574036241, 780.5160800303792, 780.5277806926841, 781.3905153979905, 14940.252987350588, 15039.248037598185, 15066.0, 15082.170480623561, 15082.472113475975, 12861.0, 13105.2136871788, 13132.146410483288, 13157.210567365988, 13228.669283267898, 10185.541650625739, 10320.58717651293, 10372.585096596127, 10611.310264832839, 10643.78712425755, 3581.5881173665102, 3591.712662986955, 3620.294042661682, 3678.098865777875, 3842.4620553122586, 78619.21380786176, 79648.00879977988, 79915.0, 79999.60000199961, 83127.5843620778, 9507.0, 9682.322237443452, 9724.416535007922, 9741.464219467856, 9851.16265117473, 21326.78673213248, 21341.679874801892, 21345.35963921085, 21351.67972480414, 21411.143554257655, 7531.849363012709, 7617.27635874591, 7646.9617651911385, 7647.158812530728, 7819.882701759479, 3457.481377793351, 4127.9174416511505, 4198.748075115503, 4291.120320334324, 4460.219461594208, 3766.0, 3776.678982286536, 3795.5065841440987, 3799.50606421169, 3814.5231846019246, 599.9610025348338, 652.5073569455031, 679.4394624434861, 684.1072400517273, 702.3152426384337, 606.2149516376303, 619.8109576579096, 629.3894921925724, 637.4804534304619, 642.7557528139371, 8034.0, 8197.46716463428, 8333.791655208668, 8483.194096560817, 8822.0, 612.4948958758698, 615.3477314047125, 625.6183727925961, 628.1143587541544, 629.1789215074281, 3633.636636336398, 3843.327417701891, 4009.0979529605606, 4063.9796801015805, 4189.287821070426, 91976.6203506948, 93807.0, 93813.0, 93929.0, 94029.11941761126, 75650.48699025989, 75677.62161189159, 77315.22684773081, 77758.0, 78438.0, 70376.64811675908, 71498.2850171502, 72933.0, 73560.0, 74522.62738686381, 7931.5637639930355, 8116.918830811853, 8142.796430089295, 8203.0, 8215.0, 48453.5154648449, 50726.0, 50878.0, 50910.0, 51413.7429312851, 66030.33969660242, 68102.31897680959, 72318.0, 72750.0, 72863.63568182125, 11258.324500529667, 11385.715357116138, 11579.07367410622, 11818.349990750592, 11921.701957450787, 12044.0, 12082.939585302018, 12246.387680615755, 12261.877381226073, 12984.0, 11477.885221148015, 11488.080953523866, 11600.6519804406, 11880.465379058136, 11922.986546143675, 10088.394696318244, 11598.884011160118, 12006.879931200576, 12130.575429859913, 12247.75504489923, 11221.495032723711, 11755.529778809094, 11845.940770296438, 11899.702507437383, 11990.220635658654, 7520.962395187989, 9296.628134874529, 9918.950405247928, 9921.801563968536, 9938.503074846374, 9798.265130115127, 9984.301098923297, 9991.750206244902, 9995.850062248926, 10004.0], "value": 7133.59913370706, "unit": "score"}], "name": "dromaeo_css", "value": 7509.228148309689, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 118.0, 111.0, 112.0, 113.0, 112.0, 113.0, 115.0, 132.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 128.0, 143.0, 165.0, 120.0, 138.0, 117.0, 153.0, 154.0, 119.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 190.0, 186.0, 184.0, 185.0, 185.0, 187.0, 185.0, 182.0, 185.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 73.0, 153.0, 55.0, 55.0, 57.0, 64.0, 134.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 88.0, 144.0, 79.0, 84.0, 90.0, 124.0, 80.0, 76.0, 127.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 88.0, 87.0, 89.0, 86.0, 89.0, 84.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 100.0, 139.0, 94.0, 95.0, 96.0, 94.0, 95.0], "value": 99.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 84.0, 84.0, 84.0, 84.0, 86.0, 84.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 60.0, 87.0, 97.0, 89.0, 62.0, 76.0, 58.0, 55.0], "value": 70.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 71.0, 66.0, 76.0, 72.0, 68.0, 68.0, 67.0, 68.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 79.0, 79.0, 80.0, 77.0, 89.0, 103.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 124.0, 125.0, 123.0, 126.0, 120.0, 134.0, 147.0, 137.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 163.0, 161.0, 200.0, 218.0, 165.0, 161.0, 161.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 85.0, 93.0, 96.0, 95.0, 70.0, 67.0, 67.0, 66.0], "value": 77.4, "unit": "score"}], "name": "kraken", "value": 1492.2, "alertThreshold": 2.0}]} 23:26:30 INFO - Return code: 0 23:26:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:26:30 ERROR - # TBPL SUCCESS # 23:26:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:26:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:26:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:26:30 INFO - 2016-07-02 23:26:30.791 screenresolution[2376:50078] starting screenresolution argv=screenresolution get 23:26:30 INFO - 2016-07-02 23:26:30.794 screenresolution[2376:50078] Display 0: 1600x1200x32@60 23:26:30 INFO - 2016-07-02 23:26:30.800 screenresolution[2377:50081] starting screenresolution argv=screenresolution list 23:26:30 INFO - Available Modes on Display 0 23:26:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:26:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:26:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:26:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:26:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:26:31 INFO - Intel Iris: 23:26:31 INFO - Chipset Model: Intel Iris 23:26:31 INFO - Type: GPU 23:26:31 INFO - Bus: Built-In 23:26:31 INFO - VRAM (Dynamic, Max): 1536 MB 23:26:31 INFO - Vendor: Intel (0x8086) 23:26:31 INFO - Device ID: 0x0a2e 23:26:31 INFO - Revision ID: 0x0009 23:26:31 INFO - Displays: 23:26:31 INFO - Display: 23:26:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:26:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:26:31 INFO - Display Serial Number: 1600x1200 60 23:26:31 INFO - Main Display: Yes 23:26:31 INFO - Mirror: Off 23:26:31 INFO - Online: Yes 23:26:31 INFO - Rotation: Supported 23:26:31 INFO - Return code: 0 23:26:31 INFO - Running post-action listener: _resource_record_post_action 23:26:31 INFO - Running post-run listener: _resource_record_post_run 23:26:32 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 290816; Write bytes: 494042624; Read time: 3; Write time: 1521 23:26:32 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193204736; Write bytes: 185831424; Read time: 17674; Write time: 409 23:26:32 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 290816; Write bytes: 298470912; Read time: 3; Write time: 1080 23:26:32 INFO - Running post-run listener: _upload_blobber_files 23:26:32 INFO - Blob upload gear active. 23:26:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:26:32 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 23:26:32 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'] 23:26:32 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 23:26:32 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:26:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:26:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:33 INFO - (blobuploader) - INFO - Done attempting. 23:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:34 INFO - (blobuploader) - INFO - Done attempting. 23:26:34 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:34 INFO - Return code: 0 23:26:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:26:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b6c035a7874dab3a064cdcb02e8b64fa5e714d10c20d495abd1b76d33c5089d96949976dd5a3ce9d2084f62a6f8325ff73f034557e0d5a6a156a10dee4d5107", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06080f9e017f57a61dfc881807c1e082c6052bfccf642a475bfcd4a476994c96fd540f28189eb4422cf60384b6e242e5d021b98413699b8e989fc1527727e24d"} 23:26:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:26:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:26:34 INFO - Contents: 23:26:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b6c035a7874dab3a064cdcb02e8b64fa5e714d10c20d495abd1b76d33c5089d96949976dd5a3ce9d2084f62a6f8325ff73f034557e0d5a6a156a10dee4d5107", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06080f9e017f57a61dfc881807c1e082c6052bfccf642a475bfcd4a476994c96fd540f28189eb4422cf60384b6e242e5d021b98413699b8e989fc1527727e24d"} 23:26:34 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:34 INFO - Copying logs to upload dir... 23:26:34 INFO - mkdir: /builds/slave/test/build/upload/logs 23:26:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.116612 ========= master_lag: 0.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-02 23:26:35.115141) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 19 secs) (at 2016-07-02 23:26:35.118500) ========= 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.APmO15TsVR/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.7OGKjV201o/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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/9b6c035a7874dab3a064cdcb02e8b64fa5e714d10c20d495abd1b76d33c5089d96949976dd5a3ce9d2084f62a6f8325ff73f034557e0d5a6a156a10dee4d5107", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06080f9e017f57a61dfc881807c1e082c6052bfccf642a475bfcd4a476994c96fd540f28189eb4422cf60384b6e242e5d021b98413699b8e989fc1527727e24d"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011182 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b6c035a7874dab3a064cdcb02e8b64fa5e714d10c20d495abd1b76d33c5089d96949976dd5a3ce9d2084f62a6f8325ff73f034557e0d5a6a156a10dee4d5107", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06080f9e017f57a61dfc881807c1e082c6052bfccf642a475bfcd4a476994c96fd540f28189eb4422cf60384b6e242e5d021b98413699b8e989fc1527727e24d"}' ========= master_lag: 19.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 19 secs) (at 2016-07-02 23:26:54.656032) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:54.656378) ========= 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.APmO15TsVR/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.7OGKjV201o/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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.005324 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:54.684724) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:26:54.685009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:26:54.685307) ========= ========= Total master_lag: 20.12 =========