builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0338 starttime: 1468897913.75 results: success (0) buildid: 20160718082858 builduid: 45ab1cec1c9e4d789d92b52f048d1303 revision: 0f4257230dffa106e90cf736df9dbe9859ac5274 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:53.754454) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:53.754883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:53.755180) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:53.779163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:53.779474) ========= 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.cY5YOhIdRI/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.vhQSmYR695/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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-18 20:11:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2016-07-18 20:11:53 (18.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:53.968763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:53.972109) ========= 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.cY5YOhIdRI/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.vhQSmYR695/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.026577 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:54.020904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:54.021269) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f4257230dffa106e90cf736df9dbe9859ac5274 --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 0f4257230dffa106e90cf736df9dbe9859ac5274 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cY5YOhIdRI/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.vhQSmYR695/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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-18 20:11:54,102 truncating revision to first 12 chars 2016-07-18 20:11:54,102 Setting DEBUG logging. 2016-07-18 20:11:54,102 attempt 1/10 2016-07-18 20:11:54,102 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0f4257230dff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 20:11:54,467 unpacking tar archive at: mozilla-beta-0f4257230dff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:54.769698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:54.770074) ========= script_repo_revision: 0f4257230dffa106e90cf736df9dbe9859ac5274 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:54.771387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:54.771666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:11:54.790663) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-18 20:11:54.790986) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cY5YOhIdRI/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.vhQSmYR695/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:11:54 INFO - MultiFileLogger online at 20160718 20:11:54 in /builds/slave/test 20:11:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:11:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:11:54 INFO - {'append_to_log': False, 20:11:54 INFO - 'base_work_dir': '/builds/slave/test', 20:11:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:11:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:11:54 INFO - 'branch': 'Mozilla-Beta', 20:11:54 INFO - 'buildbot_json_path': 'buildprops.json', 20:11:54 INFO - 'config_files': ('talos/mac_config.py',), 20:11:54 INFO - 'default_actions': ('clobber', 20:11:54 INFO - 'read-buildbot-config', 20:11:54 INFO - 'download-and-extract', 20:11:54 INFO - 'populate-webroot', 20:11:54 INFO - 'create-virtualenv', 20:11:54 INFO - 'install', 20:11:54 INFO - 'run-tests'), 20:11:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:11:54 INFO - 'download_minidump_stackwalk': True, 20:11:54 INFO - 'download_symbols': 'ondemand', 20:11:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:11:54 INFO - 'tooltool.py': '/tools/tooltool.py', 20:11:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:11:54 INFO - '/tools/misc-python/virtualenv.py')}, 20:11:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:11:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:11:54 INFO - 'installer_path': 'installer.exe', 20:11:54 INFO - 'log_level': 'info', 20:11:54 INFO - 'log_name': 'talos', 20:11:54 INFO - 'log_to_console': True, 20:11:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:11:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:11:54 INFO - 'opt_config_files': (), 20:11:54 INFO - 'pip_index': False, 20:11:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:11:54 INFO - 'cmd': ('bash', 20:11:54 INFO - '-c', 20:11:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:11:54 INFO - 'enabled': True, 20:11:54 INFO - 'halt_on_failure': False, 20:11:54 INFO - 'name': 'check_screen_resolution'},), 20:11:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:11:54 INFO - 'cmd': ('bash', 20:11:54 INFO - '-c', 20:11:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:11:54 INFO - 'enabled': True, 20:11:54 INFO - 'halt_on_failure': False, 20:11:54 INFO - 'name': 'check_screen_resolution'},), 20:11:54 INFO - 'run_cmd_checks_enabled': True, 20:11:54 INFO - 'sps_profile': False, 20:11:54 INFO - 'sps_profile_interval': 0, 20:11:54 INFO - 'suite': 'dromaeojs-e10s', 20:11:54 INFO - 'system_bits': '32', 20:11:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:11:54 INFO - 'title': 't-yosemite-r7-0338', 20:11:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:11:54 INFO - 'use_talos_json': True, 20:11:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:11:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:11:54 INFO - 'work_dir': 'build'} 20:11:54 INFO - ##### 20:11:54 INFO - ##### Running clobber step. 20:11:54 INFO - ##### 20:11:54 INFO - Running pre-action listener: _resource_record_pre_action 20:11:54 INFO - Running main action method: clobber 20:11:54 INFO - rmtree: /builds/slave/test/build 20:11:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:11:57 INFO - Running post-action listener: _resource_record_post_action 20:11:57 INFO - ##### 20:11:57 INFO - ##### Running read-buildbot-config step. 20:11:57 INFO - ##### 20:11:57 INFO - Running pre-action listener: _resource_record_pre_action 20:11:57 INFO - Running main action method: read_buildbot_config 20:11:57 INFO - Using buildbot properties: 20:11:57 INFO - { 20:11:57 INFO - "project": "", 20:11:57 INFO - "product": "firefox", 20:11:57 INFO - "script_repo_revision": "production", 20:11:57 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 20:11:57 INFO - "repository": "", 20:11:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 20:11:57 INFO - "buildid": "20160718082858", 20:11:57 INFO - "pgo_build": "False", 20:11:57 INFO - "basedir": "/builds/slave/test", 20:11:57 INFO - "buildnumber": 30, 20:11:57 INFO - "slavename": "t-yosemite-r7-0338", 20:11:57 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 20:11:57 INFO - "platform": "yosemite_r7", 20:11:57 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:11:57 INFO - "branch": "mozilla-beta", 20:11:57 INFO - "repo_path": "releases/mozilla-beta", 20:11:57 INFO - "revision": "0f4257230dffa106e90cf736df9dbe9859ac5274", 20:11:57 INFO - "stage_platform": "macosx64", 20:11:57 INFO - "builduid": "45ab1cec1c9e4d789d92b52f048d1303", 20:11:57 INFO - "slavebuilddir": "test" 20:11:57 INFO - } 20:11:57 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg. 20:11:57 INFO - Running post-action listener: _resource_record_post_action 20:11:57 INFO - ##### 20:11:57 INFO - ##### Running download-and-extract step. 20:11:57 INFO - ##### 20:11:57 INFO - Running pre-action listener: _resource_record_pre_action 20:11:57 INFO - Running main action method: download_and_extract 20:11:57 INFO - mkdir: /builds/slave/test/build/tests 20:11: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')]} 20:11:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.test_packages.json 20:11:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:11:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/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 20:11:57 INFO - Downloaded 1165 bytes. 20:11:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:11:57 INFO - Using the following test package requirements: 20:11:57 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:11:57 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:11:57 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 20:11:57 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:11:57 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 20:11:57 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:11:57 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:11:57 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 20:11:57 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:11:57 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:11:57 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 20:11:57 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:11:57 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 20:11:57 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:11:57 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 20:11:57 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:11:57 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 20:11:57 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 20:11: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')]} 20:11:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.common.tests.zip 20:11:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 20:11:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/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 20:11:57 INFO - Downloaded 18314732 bytes. 20:11:57 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'] 20:11:57 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 20:12:00 INFO - Return code: 0 20:12:00 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 20:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:00 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.common.tests.zip 20:12:00 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 20:12:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/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 20:12:00 INFO - Downloaded 18314732 bytes. 20:12:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:12:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:12:04 INFO - Return code: 0 20:12:04 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')]} 20:12:04 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.talos.tests.zip 20:12:04 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 20:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/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 20:12:05 INFO - Downloaded 10840145 bytes. 20:12:05 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'] 20:12:05 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 20:12:05 INFO - Return code: 0 20:12: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')]} 20:12:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg 20:12:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 20:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 20:12:06 INFO - Downloaded 86193191 bytes. 20:12:06 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg 20:12:06 INFO - mkdir: /builds/slave/test/properties 20:12:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:12:06 INFO - Writing to file /builds/slave/test/properties/build_url 20:12:06 INFO - Contents: 20:12:06 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg 20:12:06 INFO - Running post-action listener: _resource_record_post_action 20:12:06 INFO - Running post-action listener: set_extra_try_arguments 20:12:06 INFO - ##### 20:12:06 INFO - ##### Running populate-webroot step. 20:12:06 INFO - ##### 20:12:06 INFO - Running pre-action listener: _resource_record_pre_action 20:12:06 INFO - Running main action method: populate_webroot 20:12:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:12:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:12:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:12:06 INFO - '--tppagecycles', 20:12:06 INFO - '7'], 20:12:06 INFO - 'tests': ['tsvgm']}}, 20:12:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:12:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:12:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:12:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:12:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:12:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:12:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:06 INFO - 'talos_options': ['--disable-e10s'], 20:12:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:12:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:12:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:06 INFO - 'talos_options': ['--disable-e10s'], 20:12:06 INFO - 'tests': ['damp', 'tps']}, 20:12:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:06 INFO - 'tests': ['damp', 'tps']}, 20:12:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:12:06 INFO - 'tests': ['dromaeo_dom']}, 20:12:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:12:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:12:06 INFO - 'tests': ['a11yr', 20:12:06 INFO - 'ts_paint', 20:12:06 INFO - 'tpaint', 20:12:06 INFO - 'sessionrestore', 20:12:06 INFO - 'sessionrestore_no_auto_restore', 20:12:06 INFO - 'tabpaint']}, 20:12:06 INFO - 'other-e10s': {'tests': ['a11yr', 20:12:06 INFO - 'ts_paint', 20:12:06 INFO - 'tpaint', 20:12:06 INFO - 'sessionrestore', 20:12:06 INFO - 'sessionrestore_no_auto_restore', 20:12:06 INFO - 'tabpaint']}, 20:12:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:12:06 INFO - 'ts_paint', 20:12:06 INFO - 'tpaint', 20:12:06 INFO - 'sessionrestore', 20:12:06 INFO - 'sessionrestore_no_auto_restore', 20:12:06 INFO - 'tabpaint']}, 20:12:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:12:06 INFO - 'ts_paint', 20:12:06 INFO - 'tpaint', 20:12:06 INFO - 'sessionrestore', 20:12:06 INFO - 'sessionrestore_no_auto_restore', 20:12:06 INFO - 'tabpaint']}, 20:12:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:12:06 INFO - 'tests': ['a11yr', 20:12:06 INFO - 'ts_paint', 20:12:06 INFO - 'tpaint', 20:12:06 INFO - 'sessionrestore', 20:12:06 INFO - 'sessionrestore_no_auto_restore', 20:12:06 INFO - 'tabpaint']}, 20:12:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:12:06 INFO - 'tests': ['a11yr', 20:12:06 INFO - 'ts_paint', 20:12:06 INFO - 'tpaint', 20:12:06 INFO - 'sessionrestore', 20:12:06 INFO - 'sessionrestore_no_auto_restore', 20:12:06 INFO - 'tabpaint']}, 20:12:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:12:06 INFO - 'tests': ['tsvgx', 20:12:06 INFO - 'tsvgr_opacity', 20:12:06 INFO - 'tart', 20:12:06 INFO - 'tscrollx', 20:12:06 INFO - 'cart']}, 20:12:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:12:06 INFO - 'tsvgr_opacity', 20:12:06 INFO - 'tart', 20:12:06 INFO - 'tscrollx', 20:12:06 INFO - 'cart']}, 20:12:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:06 INFO - 'talos_options': ['--disable-e10s'], 20:12:06 INFO - 'tests': ['tp5o']}, 20:12:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:06 INFO - 'tests': ['tp5o']}, 20:12:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:06 INFO - 'talos_options': ['--disable-e10s', 20:12:06 INFO - '--xperf_path', 20:12:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:12:06 INFO - 'tests': ['tp5n']}, 20:12:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:12:06 INFO - 'talos_options': ['--xperf_path', 20:12:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:12:06 INFO - 'tests': ['tp5n']}}, 20:12:06 INFO - 'talos.zip': {'path': '', 20:12:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:12:06 INFO - Running post-action listener: _resource_record_post_action 20:12:06 INFO - ##### 20:12:06 INFO - ##### Running create-virtualenv step. 20:12:06 INFO - ##### 20:12:06 INFO - Running pre-action listener: _resource_record_pre_action 20:12:06 INFO - Running main action method: create_virtualenv 20:12:06 INFO - Creating virtualenv /builds/slave/test/build/venv 20:12:06 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 20:12:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:12:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:12:06 INFO - Using real prefix '/tools/python27' 20:12:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:12:07 INFO - Installing distribute.............................................................................................................................................................................................done. 20:12:10 INFO - Installing pip.................done. 20:12:10 INFO - Return code: 0 20:12:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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')]} 20:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11005c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3324780d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feebe00>, '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 0x10fd54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee6b20>, '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.cY5YOhIdRI/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.vhQSmYR695/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:12: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', 'pip>=1.5'] in /builds/slave/test/build 20:12: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 pip>=1.5 20:12:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY5YOhIdRI/Render', 20:12:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:10 INFO - 'HOME': '/Users/cltbld', 20:12:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:10 INFO - 'LOGNAME': 'cltbld', 20:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:10 INFO - 'MOZ_NO_REMOTE': '1', 20:12:10 INFO - 'NO_EM_RESTART': '1', 20:12:10 INFO - 'PAGER': '/bin/cat', 20:12:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:10 INFO - 'PWD': '/builds/slave/test', 20:12:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:10 INFO - 'SHELL': '/bin/bash', 20:12:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhQSmYR695/Listeners', 20:12:10 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:12:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:10 INFO - 'USER': 'cltbld', 20:12:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:10 INFO - 'XPC_FLAGS': '0x0', 20:12:10 INFO - 'XPC_SERVICE_NAME': '0', 20:12:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:10 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 20:12:10 INFO - Cleaning up... 20:12:10 INFO - Return code: 0 20:12:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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')]} 20:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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', '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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11005c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3324780d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feebe00>, '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 0x10fd54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee6b20>, '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.cY5YOhIdRI/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.vhQSmYR695/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:12: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', 'psutil>=0.7.1'] in /builds/slave/test/build 20:12: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 psutil>=0.7.1 20:12:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY5YOhIdRI/Render', 20:12:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:10 INFO - 'HOME': '/Users/cltbld', 20:12:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:10 INFO - 'LOGNAME': 'cltbld', 20:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:10 INFO - 'MOZ_NO_REMOTE': '1', 20:12:10 INFO - 'NO_EM_RESTART': '1', 20:12:10 INFO - 'PAGER': '/bin/cat', 20:12:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:10 INFO - 'PWD': '/builds/slave/test', 20:12:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:10 INFO - 'SHELL': '/bin/bash', 20:12:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhQSmYR695/Listeners', 20:12:10 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:12:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:10 INFO - 'USER': 'cltbld', 20:12:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:10 INFO - 'XPC_FLAGS': '0x0', 20:12:10 INFO - 'XPC_SERVICE_NAME': '0', 20:12:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:10 INFO - Downloading/unpacking psutil>=0.7.1 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:12:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:12:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:12:13 INFO - Installing collected packages: psutil 20:12:13 INFO - Running setup.py install for psutil 20:12:13 INFO - building 'psutil._psutil_osx' extension 20:12:13 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 20:12:14 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 20:12:14 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 20:12:14 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 20:12:14 INFO - building 'psutil._psutil_posix' extension 20:12:14 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 20:12:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:12:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:12:14 INFO - ^ 20:12:14 INFO - 1 warning generated. 20:12:14 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 20:12:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:12:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:12:14 INFO - Successfully installed psutil 20:12:14 INFO - Cleaning up... 20:12:14 INFO - Return code: 0 20:12:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:12:14 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')]} 20:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:14 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')]} 20:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:14 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11005c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3324780d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feebe00>, '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 0x10fd54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee6b20>, '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.cY5YOhIdRI/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.vhQSmYR695/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:12:14 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 20:12:14 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 20:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY5YOhIdRI/Render', 20:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:14 INFO - 'HOME': '/Users/cltbld', 20:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:14 INFO - 'LOGNAME': 'cltbld', 20:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:14 INFO - 'MOZ_NO_REMOTE': '1', 20:12:14 INFO - 'NO_EM_RESTART': '1', 20:12:14 INFO - 'PAGER': '/bin/cat', 20:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:14 INFO - 'PWD': '/builds/slave/test', 20:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:14 INFO - 'SHELL': '/bin/bash', 20:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhQSmYR695/Listeners', 20:12:14 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:14 INFO - 'USER': 'cltbld', 20:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:14 INFO - 'XPC_FLAGS': '0x0', 20:12:14 INFO - 'XPC_SERVICE_NAME': '0', 20:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:12:17 INFO - Installing collected packages: mozsystemmonitor 20:12:17 INFO - Running setup.py install for mozsystemmonitor 20:12:17 INFO - Successfully installed mozsystemmonitor 20:12:17 INFO - Cleaning up... 20:12:17 INFO - Return code: 0 20:12:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:12:17 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')]} 20:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:17 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')]} 20:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:17 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11005c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3324780d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feebe00>, '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 0x10fd54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee6b20>, '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.cY5YOhIdRI/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.vhQSmYR695/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:12:17 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 20:12:17 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 20:12:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY5YOhIdRI/Render', 20:12:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:17 INFO - 'HOME': '/Users/cltbld', 20:12:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:17 INFO - 'LOGNAME': 'cltbld', 20:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:17 INFO - 'MOZ_NO_REMOTE': '1', 20:12:17 INFO - 'NO_EM_RESTART': '1', 20:12:17 INFO - 'PAGER': '/bin/cat', 20:12:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:17 INFO - 'PWD': '/builds/slave/test', 20:12:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:17 INFO - 'SHELL': '/bin/bash', 20:12:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhQSmYR695/Listeners', 20:12:17 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:12:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:17 INFO - 'USER': 'cltbld', 20:12:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:17 INFO - 'XPC_FLAGS': '0x0', 20:12:17 INFO - 'XPC_SERVICE_NAME': '0', 20:12:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:18 INFO - Downloading/unpacking blobuploader==1.2.4 20:12:18 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 20:12:18 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 20:12:18 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 20:12:18 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 20:12:18 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 20:12:18 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 20:12:20 INFO - Downloading blobuploader-1.2.4.tar.gz 20:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:12:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:12:20 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 20:12:20 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 20:12:20 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 20:12:20 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 20:12:20 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 20:12:20 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 20:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:12:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:12:21 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 20:12:21 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 20:12:21 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 20:12:21 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 20:12:21 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 20:12:21 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 20:12:21 INFO - Downloading docopt-0.6.1.tar.gz 20:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:12:21 INFO - Installing collected packages: blobuploader, requests, docopt 20:12:21 INFO - Running setup.py install for blobuploader 20:12:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:12:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:12:22 INFO - Running setup.py install for requests 20:12:22 INFO - Running setup.py install for docopt 20:12:22 INFO - Successfully installed blobuploader requests docopt 20:12:22 INFO - Cleaning up... 20:12:22 INFO - Return code: 0 20:12:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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')]} 20:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:22 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11005c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3324780d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feebe00>, '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 0x10fd54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee6b20>, '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.cY5YOhIdRI/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.vhQSmYR695/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:12:22 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 20:12:22 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 20:12:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY5YOhIdRI/Render', 20:12:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:22 INFO - 'HOME': '/Users/cltbld', 20:12:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:22 INFO - 'LOGNAME': 'cltbld', 20:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:22 INFO - 'MOZ_NO_REMOTE': '1', 20:12:22 INFO - 'NO_EM_RESTART': '1', 20:12:22 INFO - 'PAGER': '/bin/cat', 20:12:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:22 INFO - 'PWD': '/builds/slave/test', 20:12:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:22 INFO - 'SHELL': '/bin/bash', 20:12:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhQSmYR695/Listeners', 20:12:22 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:12:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:22 INFO - 'USER': 'cltbld', 20:12:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:22 INFO - 'XPC_FLAGS': '0x0', 20:12:22 INFO - 'XPC_SERVICE_NAME': '0', 20:12:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:12:23 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-5thCoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:12:23 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-iGf_GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:12:23 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-LAnXVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:12:23 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-4gT9T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:12:23 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-tCpqXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:12:23 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-96_1dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:12:23 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-9NztEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:12:23 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-zFw3Az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:12:23 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-VtDtMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:12:23 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-OGOiw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:12:24 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-XfpBxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:12:24 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-693xRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:12:24 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-VZnW6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:12:24 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-qWjoou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:24 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-i52p6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:12:24 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-3J3I5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:12:24 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-grQQm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:12:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:12:24 INFO - Running setup.py install for manifestparser 20:12:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:12:24 INFO - Running setup.py install for mozcrash 20:12:25 INFO - Running setup.py install for mozdebug 20:12:25 INFO - Running setup.py install for mozdevice 20:12:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:12:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:12:25 INFO - Running setup.py install for mozfile 20:12:25 INFO - Running setup.py install for mozhttpd 20:12:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:12:25 INFO - Running setup.py install for mozinfo 20:12:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:12:25 INFO - Running setup.py install for mozInstall 20:12:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:12:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:12:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:12:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:12:25 INFO - Running setup.py install for mozleak 20:12:26 INFO - Running setup.py install for mozlog 20:12:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:12:26 INFO - Running setup.py install for moznetwork 20:12:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:12:26 INFO - Running setup.py install for mozprocess 20:12:26 INFO - Running setup.py install for mozprofile 20:12:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:12:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:12:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:12:26 INFO - Running setup.py install for mozrunner 20:12:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:12:26 INFO - Running setup.py install for mozscreenshot 20:12:27 INFO - Running setup.py install for moztest 20:12:27 INFO - Running setup.py install for mozversion 20:12:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:12:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:12:27 INFO - Cleaning up... 20:12:27 INFO - Return code: 0 20:12:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12: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')]} 20:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:27 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11005c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3324780d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feebe00>, '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 0x10fd54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee6b20>, '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.cY5YOhIdRI/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.vhQSmYR695/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:12:27 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 20:12:27 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 20:12:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY5YOhIdRI/Render', 20:12:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:27 INFO - 'HOME': '/Users/cltbld', 20:12:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:27 INFO - 'LOGNAME': 'cltbld', 20:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:27 INFO - 'MOZ_NO_REMOTE': '1', 20:12:27 INFO - 'NO_EM_RESTART': '1', 20:12:27 INFO - 'PAGER': '/bin/cat', 20:12:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:27 INFO - 'PWD': '/builds/slave/test', 20:12:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:27 INFO - 'SHELL': '/bin/bash', 20:12:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhQSmYR695/Listeners', 20:12:27 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:12:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:27 INFO - 'USER': 'cltbld', 20:12:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:27 INFO - 'XPC_FLAGS': '0x0', 20:12:27 INFO - 'XPC_SERVICE_NAME': '0', 20:12:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:12:27 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-QDW9R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:12:27 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)) 20:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:12:27 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-pHFfl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:12:27 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)) 20:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:12:27 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-21no0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:12:27 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)) 20:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:12:27 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-66G3Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:12:28 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)) 20:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:12:28 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-V9EZAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:12:28 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)) 20:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:12:28 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-WfZcJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:12:28 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)) 20:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:12:28 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-4smx26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:12:28 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)) 20:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:12:28 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-0NgBwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:12:28 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)) 20:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:12:28 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-HMJFnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:12:28 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)) 20:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:12:28 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-BcFyLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:12:28 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)) 20:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:12:28 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-GmQ75g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:12:28 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)) 20:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:12:28 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-xPKy19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:12:28 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)) 20:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:12:28 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-uDU36L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:12:28 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)) 20:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:12:28 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ma5qAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:12:29 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)) 20:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:29 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-B4hA0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:29 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)) 20:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:12:29 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-9T3Hjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:12:29 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)) 20:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:12:29 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-tq3sNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 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)) 20:12:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:12:29 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 20:12:29 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 20:12:29 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 20:12:29 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 20:12:29 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 20:12:29 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 20:12:31 INFO - Downloading blessings-1.6.tar.gz 20:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:12:31 INFO - Installing collected packages: blessings 20:12:31 INFO - Running setup.py install for blessings 20:12:32 INFO - Successfully installed blessings 20:12:32 INFO - Cleaning up... 20:12:32 INFO - Return code: 0 20:12:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:12:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:32 INFO - Reading from file tmpfile_stdout 20:12:32 INFO - Current package versions: 20:12:32 INFO - blessings == 1.6 20:12:32 INFO - blobuploader == 1.2.4 20:12:32 INFO - docopt == 0.6.1 20:12:32 INFO - manifestparser == 1.1 20:12:32 INFO - mozInstall == 1.12 20:12:32 INFO - mozcrash == 0.17 20:12:32 INFO - mozdebug == 0.1 20:12:32 INFO - mozdevice == 0.48 20:12:32 INFO - mozfile == 1.2 20:12:32 INFO - mozhttpd == 0.7 20:12:32 INFO - mozinfo == 0.9 20:12:32 INFO - mozleak == 0.1 20:12:32 INFO - mozlog == 3.1 20:12:32 INFO - moznetwork == 0.27 20:12:32 INFO - mozprocess == 0.22 20:12:32 INFO - mozprofile == 0.28 20:12:32 INFO - mozrunner == 6.11 20:12:32 INFO - mozscreenshot == 0.1 20:12:32 INFO - mozsystemmonitor == 0.0 20:12:32 INFO - moztest == 0.7 20:12:32 INFO - mozversion == 1.4 20:12:32 INFO - psutil == 3.1.1 20:12:32 INFO - requests == 1.2.3 20:12:32 INFO - wsgiref == 0.1.2 20:12:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:32 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11005c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3324780d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feebe00>, '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 0x10fd54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee6b20>, '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.cY5YOhIdRI/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.vhQSmYR695/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:12:32 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 20:12:32 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 20:12:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY5YOhIdRI/Render', 20:12:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:32 INFO - 'HOME': '/Users/cltbld', 20:12:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:32 INFO - 'LOGNAME': 'cltbld', 20:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:32 INFO - 'MOZ_NO_REMOTE': '1', 20:12:32 INFO - 'NO_EM_RESTART': '1', 20:12:32 INFO - 'PAGER': '/bin/cat', 20:12:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:32 INFO - 'PWD': '/builds/slave/test', 20:12:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:32 INFO - 'SHELL': '/bin/bash', 20:12:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhQSmYR695/Listeners', 20:12:32 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:12:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:32 INFO - 'USER': 'cltbld', 20:12:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:32 INFO - 'XPC_FLAGS': '0x0', 20:12:32 INFO - 'XPC_SERVICE_NAME': '0', 20:12:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:32 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)) 20:12:32 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)) 20:12:32 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)) 20:12:32 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)) 20:12:32 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)) 20:12:32 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)) 20:12:32 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)) 20:12:32 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)) 20:12:32 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)) 20:12:32 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)) 20:12:32 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)) 20:12:32 INFO - Cleaning up... 20:12:32 INFO - Return code: 0 20:12:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:32 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11005c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3324780d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feebe00>, '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 0x10fd54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee6b20>, '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.cY5YOhIdRI/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.vhQSmYR695/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:12:32 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 20:12:32 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 20:12:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY5YOhIdRI/Render', 20:12:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:32 INFO - 'HOME': '/Users/cltbld', 20:12:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:32 INFO - 'LOGNAME': 'cltbld', 20:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:32 INFO - 'MOZ_NO_REMOTE': '1', 20:12:32 INFO - 'NO_EM_RESTART': '1', 20:12:32 INFO - 'PAGER': '/bin/cat', 20:12:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:32 INFO - 'PWD': '/builds/slave/test', 20:12:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:32 INFO - 'SHELL': '/bin/bash', 20:12:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhQSmYR695/Listeners', 20:12:32 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:12:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:32 INFO - 'USER': 'cltbld', 20:12:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:32 INFO - 'XPC_FLAGS': '0x0', 20:12:32 INFO - 'XPC_SERVICE_NAME': '0', 20:12:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:33 INFO - Downloading/unpacking jsonschema 20:12:33 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 20:12:33 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 20:12:33 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 20:12:33 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 20:12:33 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 20:12:33 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 20:12:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:12:35 INFO - Downloading/unpacking functools32 (from jsonschema) 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:35 INFO - Downloading functools32-3.2.3-2.tar.gz 20:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:12:36 INFO - warning: no files found matching '*.txt' 20:12:36 INFO - no previously-included directories found matching 'build' 20:12:36 INFO - no previously-included directories found matching 'dist' 20:12:36 INFO - no previously-included directories found matching '.git*' 20:12:36 INFO - Installing collected packages: jsonschema, functools32 20:12:36 INFO - Running setup.py install for functools32 20:12:36 INFO - warning: no files found matching '*.txt' 20:12:36 INFO - no previously-included directories found matching 'build' 20:12:36 INFO - no previously-included directories found matching 'dist' 20:12:36 INFO - no previously-included directories found matching '.git*' 20:12:36 INFO - Successfully installed jsonschema functools32 20:12:36 INFO - Cleaning up... 20:12:36 INFO - Return code: 0 20:12:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:36 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11005c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3324780d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feebe00>, '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 0x10fd54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee6b20>, '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.cY5YOhIdRI/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.vhQSmYR695/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 20:12:36 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 20:12:36 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 20:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY5YOhIdRI/Render', 20:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:36 INFO - 'HOME': '/Users/cltbld', 20:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:36 INFO - 'LOGNAME': 'cltbld', 20:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:36 INFO - 'MOZ_NO_REMOTE': '1', 20:12:36 INFO - 'NO_EM_RESTART': '1', 20:12:36 INFO - 'PAGER': '/bin/cat', 20:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:36 INFO - 'PWD': '/builds/slave/test', 20:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:36 INFO - 'SHELL': '/bin/bash', 20:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhQSmYR695/Listeners', 20:12:36 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:36 INFO - 'USER': 'cltbld', 20:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:36 INFO - 'XPC_FLAGS': '0x0', 20:12:36 INFO - 'XPC_SERVICE_NAME': '0', 20:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:36 INFO - Downloading/unpacking flake8 20:12:36 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 20:12:36 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 20:12:36 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 20:12:36 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 20:12:36 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 20:12:36 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 20:12:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:12:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:12:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 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 20:12:39 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 20:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:12:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:12:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:12:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:12:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:12:40 INFO - no previously-included directories found matching 'docs/_build' 20:12:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:12:40 INFO - Running setup.py install for pep8 20:12:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:12:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:12:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:12:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:12:40 INFO - no previously-included directories found matching 'docs/_build' 20:12:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:12:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:12:40 INFO - Cleaning up... 20:12:40 INFO - Return code: 0 20:12:40 INFO - Running post-action listener: _resource_record_post_action 20:12:40 INFO - Running post-action listener: _start_resource_monitoring 20:12:40 INFO - Starting resource monitoring. 20:12:40 INFO - ##### 20:12:40 INFO - ##### Running install step. 20:12:40 INFO - ##### 20:12:40 INFO - Running pre-action listener: _resource_record_pre_action 20:12:40 INFO - Running main action method: install 20:12:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:41 INFO - Reading from file tmpfile_stdout 20:12:41 INFO - Detecting whether we're running mozinstall >=1.0... 20:12:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:12:41 INFO - Reading from file tmpfile_stdout 20:12:41 INFO - Output received: 20:12:41 INFO - Usage: mozinstall [options] installer 20:12:41 INFO - Options: 20:12:41 INFO - -h, --help show this help message and exit 20:12:41 INFO - -d DEST, --destination=DEST 20:12:41 INFO - Directory to install application into. [default: 20:12:41 INFO - "/builds/slave/test"] 20:12:41 INFO - --app=APP Application being installed. [default: firefox] 20:12:41 INFO - mkdir: /builds/slave/test/build/application 20:12:41 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'] 20:12:41 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 20:13:03 INFO - Reading from file tmpfile_stdout 20:13:03 INFO - Output received: 20:13:03 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:13:03 INFO - Running post-action listener: _resource_record_post_action 20:13:03 INFO - ##### 20:13:03 INFO - ##### Running run-tests step. 20:13:03 INFO - ##### 20:13:03 INFO - Running pre-action listener: _resource_record_pre_action 20:13:03 INFO - Running main action method: run_tests 20:13:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:13:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:13:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:13:03 INFO - 2016-07-18 20:13:03.294 screenresolution[1644:7423] starting screenresolution argv=screenresolution get 20:13:03 INFO - 2016-07-18 20:13:03.297 screenresolution[1644:7423] Display 0: 1600x1200x32@60 20:13:03 INFO - 2016-07-18 20:13:03.302 screenresolution[1645:7425] starting screenresolution argv=screenresolution list 20:13:03 INFO - Available Modes on Display 0 20:13:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:13:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:13:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:13:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:13:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:13:03 INFO - Intel Iris: 20:13:03 INFO - Chipset Model: Intel Iris 20:13:03 INFO - Type: GPU 20:13:03 INFO - Bus: Built-In 20:13:03 INFO - VRAM (Dynamic, Max): 1536 MB 20:13:03 INFO - Vendor: Intel (0x8086) 20:13:03 INFO - Device ID: 0x0a2e 20:13:03 INFO - Revision ID: 0x0009 20:13:03 INFO - Displays: 20:13:03 INFO - Display: 20:13:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:13:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:13:03 INFO - Display Serial Number: 1600x1200 60 20:13:03 INFO - Main Display: Yes 20:13:03 INFO - Mirror: Off 20:13:03 INFO - Online: Yes 20:13:03 INFO - Rotation: Supported 20:13:03 INFO - Return code: 0 20:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:13:03 INFO - Python 2.7.3 20:13:03 INFO - Return code: 0 20:13:03 INFO - grabbing minidump binary from tooltool 20:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:03 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 0x10feebe00>, '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 0x10fd54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:13:03 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 20:13:03 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 20:13:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:13:03 INFO - Return code: 0 20:13:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:13:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:13:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:13:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:13:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:13:04 INFO - Return code: 0 20:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0338 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY5YOhIdRI/Render', 20:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:13:04 INFO - 'HOME': '/Users/cltbld', 20:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:13:04 INFO - 'LOGNAME': 'cltbld', 20:13:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:13:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:04 INFO - 'MOZ_NO_REMOTE': '1', 20:13:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:13:04 INFO - 'NO_EM_RESTART': '1', 20:13:04 INFO - 'PAGER': '/bin/cat', 20:13:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:04 INFO - 'PWD': '/builds/slave/test', 20:13:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:13:04 INFO - 'SHELL': '/bin/bash', 20:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhQSmYR695/Listeners', 20:13:04 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 20:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:13:04 INFO - 'USER': 'cltbld', 20:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:04 INFO - 'XPC_FLAGS': '0x0', 20:13:04 INFO - 'XPC_SERVICE_NAME': '0', 20:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:13:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:13:05 INFO - mozversion application_buildid: 20160718082858 20:13:05 INFO - mozversion application_changeset: 0f4257230dffa106e90cf736df9dbe9859ac5274 20:13:05 INFO - mozversion application_display_name: Firefox 20:13:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:13:05 INFO - mozversion application_name: Firefox 20:13:05 INFO - mozversion application_remotingname: firefox 20:13:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:13:05 INFO - mozversion application_vendor: Mozilla 20:13:05 INFO - mozversion application_version: 48.0 20:13:05 INFO - mozversion platform_buildid: 20160718082858 20:13:05 INFO - mozversion platform_changeset: 0f4257230dffa106e90cf736df9dbe9859ac5274 20:13:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:13:05 INFO - mozversion platform_version: 48.0 20:13:05 INFO - using testdate: 1468897985 20:13:05 INFO - actual date: 1468897985 20:13:05 INFO - starting webserver on 'localhost:49271' 20:13:05 INFO - SUITE-START | Running 2 tests 20:13:05 INFO - TEST-START | dromaeo_css 20:13:05 INFO - operating with platform_type : mac_ 20:13:05 INFO - Initialising browser for dromaeo_css test... 20:13:05 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpXXdoGW/profile http://localhost:49271/getInfo.html) 20:13:08 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 20:13:08 INFO - PROCESS | 1663 | colorDepth:24 20:13:08 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 20:13:08 INFO - PROCESS | 1663 | __metrics 20:13:08 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 20:13:08 INFO - TEST-INFO | 1663: exit 0 20:13:08 INFO - Browser initialized. 20:13:08 INFO - Running cycle 1/1 for dromaeo_css test... 20:13:08 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpXXdoGW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:13:20 INFO - PROCESS | 1667 | RSS: Main: 170971136 20:13:20 INFO - PROCESS | 1667 | 20:14:10 INFO - PROCESS | 1667 | 1468898050390 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] 20:16:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 20:16:22 INFO - PROCESS | 1667 | RSS: Main: 185106432 20:16:22 INFO - PROCESS | 1667 | 20:19:24 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 20:19:24 INFO - PROCESS | 1667 | RSS: Main: 195727360 20:19:24 INFO - PROCESS | 1667 | 20:22:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 20:22:26 INFO - PROCESS | 1667 | RSS: Main: 197677056 20:22:26 INFO - PROCESS | 1667 | 20:25:28 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 20:25:29 INFO - PROCESS | 1667 | RSS: Main: 201564160 20:25:29 INFO - PROCESS | 1667 | 20:28:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 20:28:32 INFO - PROCESS | 1667 | RSS: Main: 200544256 20:28:32 INFO - PROCESS | 1667 | 20:31:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 20:31:34 INFO - PROCESS | 1667 | RSS: Main: 205639680 20:31:34 INFO - PROCESS | 1667 | 20:31:34 INFO - PROCESS | 1667 | __start_tp_report 20:31:34 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 20:31:34 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 20:31:34 INFO - PROCESS | 1667 | |i|pagename|runs| 20:31:34 INFO - PROCESS | 1667 | |0;dojo.html;3139.8430078496085;3678.1356381250403;3712.777233365998;3715.4798328234033;3742.644448777367;5878.970605146968;6139.079138129283;6149.754009839607;6180;6192.380761923811;4425.430305442243;6021.277446706401;6106.572539922207;6111.297200821907;6185.721642526086;5474.507294343508;5500.42245564216;5523.005858945408;5571.609987300891;5622.409646987069;5495.422980587041;5553.666779993193;5576.776928922838;5588.608797384185;5665.008623490872;5554.0835762099405;5558.749856256478;5572.080606699889;5575.804846830361;5586.748596313156;5550.333959924795;5554.444555544454;5574.9721251393485;5581.8604534886545;5595.356533998602;5484.588655850827;5537.750801213955;5550.333959924795;5569.359523654791;5587.636803607753;5910.615809972338;5965.3139888912465;5984.760609575612;6108.847278818021;6142.385761423867;6437.388448097423;6482.7406903723795;6482.870342593169;6500.4474619657385;6504.349565043505;6536.986767051115;6560.805461362673;6581.21025476941;6585.835354116185;6602.40578347951;6116.548817443993;6153.723082461211;6180.783672571529;6209.130721698965;6222.875542489125;6640.103586015826;6715.597064176165;6720.059191713164;6724.092247546519;6737.831554211184;6375.458086062644;6416.197975253093;6417.2299324081405;6418.422341989243;6439.710213040425;6404.39158279972;6441.581297215666;6472.093906853044;6503.544751867324;6615.669216539154;6434.64609446485;6471.126397936312;6479.319671434526;6485.6108633482145;6486.902696459557;4769.9046019080115;5220.477952204749;5425.538829199483;6485.44873685742;6491.253505846888;5102.36220472441;5143.6399452037995;5200.167973124282;5222.843314700565;5271.971965466697;4655.580997710223;4662.417197850269;4663.183942810063;4675.13510000651;4726.3146843708155;5997.880042399128;6153.046277826944;6193;6232.065190221503;6271.937280627135;6443.454835340014;6543.901841472381;6568.244651865001;6601.768938087144;6657.900131498031;6276.905846412307;6289.0880822280515;6292.056191571301;6306.684665766693;6317.747290108436;5678.886422271531;5749.1663708762835;5796.5072968797285;5806.44838740319;5807.419258074243;6738;6751.291114433012;6766.526343156129;6772.119624448888;6773.085633439521;6567.507436942153;6588.769393071219;6593.241777195492;6614.570052946543;6624.768133115318;6620.106285651375;6694.430973367318;6780.627065511247;6796.490263230178;6802.897956530557;6483.157189565326;6488.772892948724;6513;6527.738890444329;6541.476681865344;6535.117759102461;6626.602403855784;6631.469482441489;6638.76764313266;6655.23464801554;6277.623342599459;6354.618722876642;6357.7139028742895;6374.26695929974;6383.96808015957;6357.777477788255;6373.426391624776;6378.075179099097;6383.265924418752;6397.936020639734;5876.588638795243;6201.10084037803;6275.184226050585;6285.905711414241;6291.685415729286;5997.130416089555;6216.067589861557;6274.592151510137;6357.237131544244;6363.490920726238;6248.375162483897;6285.654289014148;6288.056791481315;6292.748290068346;6297.685115744286 20:31:34 INFO - PROCESS | 1667 | |1;ext.html;542.4033563080611;581.7847396463309;583.4602992232184;606.9453749162575;675.739745374876;34013.82993085034;39372.60627393725;39398.803005985;39550.20899582007;39559.80220098899;41270.79364603173;41626.167476650524;41663.375049374285;41749.74750757474;41783.95540111499;8285.295749861269;9457.57440915157;9569.856452153223;9693.903060969405;9702.17531509819;9691.176250018756;9805.117539421452;9826.410415375065;9841.852372214422;9913;9835;9916.652917147901;9929.702108936708;9938.55276512555;9971.351862128975;9812.95093524535;9868.506574671237;9897.60409583623;9928.404295742279;9956.551955162035;9681.789776277965;9748.171405430547;9759.609615615367;9780.510974451248;9792.510374481248;39184.41223381652;39369.40945885814;39565.80217098925;39595.20809583821;39655;3090.7990980586414;3293.5883014623173;3379;3405.7786243894316;3606.1525541497726;24036.399090022715;26837.32906677329;28678.569821452696;29889.551656725165;30349.848250758827;2759.503289407906;2784.317842128671;2799.9300017499727;2806.480801051812;2816.7183281671873;387865.0606746976;434722;459763;462736;463409;37327.62672373296;38118.61881381151;50847.47457576279;60870;61706;30593;35966;36448.453273200925;36506;37019.814900925325;15823;15989.360425582847;16416.261268242957;16546.58633534147;16561.42035028768;11938.164328496921;13967.580972570839;14051.929740351234;14167.504137355143;14241.928790356189;8398.286145677564;8452.8732069019;8494.023187333536;8525.976882773983;8566.014908285628;3543.8936831895085;3557.4308110702164;3569.7501174917506;3579.19468119671;3580.606133325332;1043.9008294212038;1065.2436769893463;1106.80630889594;1203.1998720850536;1211.660734994203;30377.544336834966;30425.69574304273;30652.38695226083;30823.38353232923;31142.22144446407;1068.834330678746;1196.407778149804;1199.8920097191294;1243.9191452555556;1291.560869304422;12339.6915077122;15152.545423637088;15397.307121179574;15513.922430387776;15974.840251597569;620695;621877;627651;628699;630766.5385019229;59407.70296148578;60657.39342606605;60870.39129608736;61477;61800.381996179465;1494.1782019889235;1509.5848641623422;1510.909345439277;1521.1481570320657;1522.2464879884308;29760.553591696575;30497.695023049484;30538.389232215675;30634.072944868276;30834;53721;53996.190057148386;54009;54194;54232.72883635556;570646;572624;572911;574820;575974;26483.735162648896;27704.445911081264;27852.30369240785;27947.301317467227;28375.858120709265;46572.76713616546;46623.76688116538;48192;48539.27191092066;48582;38887.73110244376;38973.02567435837;39080.609193907694;39436;39874.2025159501;31002.68997309998;38428.80785596054;38594.0351491215;38903.41644875386;38976.830695079196;38203.42694859635;38720;39626.009349766486;40354.59645403508;40553.391699125124;31728.682713172573;33847.49228761521;33900.66099338975;33940;34218.48672269968;24445.51108977846;26604.733952660226;26662.06682766094;26993.595096073183;27044.72955270501 20:31:34 INFO - PROCESS | 1667 | |2;jquery.html;348.72019687745967;407.85317285777114;413.61947008751946;421.1555830559727;424.2617844949788;16104.436344727937;20884.37346879594;21651.99999999998;21750.89124554377;21930.4517387065;21268.57462850742;21373.465663358424;21558.568828623418;21653.783462165375;21726.89136554315;5760.596758226915;5838.9124163137585;6066.059760737093;6120.081987701858;6128.8467788305425;5951.285845698522;5952.970235148819;5958.612690175125;6044.153818465396;6061.545384096188;5869.735861886204;5896.557758168155;5923.111533270023;5985.5810093293485;6099.817005489843;5267.578593712494;5875.206847075676;5915.911261331084;6004.819855404323;6034.5172386209215;5144.922826157611;5235.371755389339;5265.131253343194;5267.789288428458;5286.841394758163;20835.062422191037;21551.461213469633;26571.80426880795;26982.5952610711;27304.63476826151;2231.854929429598;2265.9546809063727;2513.937151571207;2515.320863366899;2589.5597748382634;15062.397504099823;15123.924380378028;15460.458883939009;15607.843921560867;15657.686846263012;1563.9687206255926;1798.1818272685896;1850.5281153305955;1867.7758668959675;1882.9717554236697;112267;113254.43372783165;113534.86465135326;116337;118488.63022739583;11126.332420054823;11561.88438115625;11677.474513646906;11744;12155.5137794489;14368.634979676914;14442.33913100007;14474.348654310581;14579.927100364643;14596.927015365067;8427.915720842713;8767.780805479786;8769.38614297006;8896.688615898413;8903.421277616933;8872.911270887338;8978.461292322481;8994.50530220831;9057.547122643842;9124.680636177834;4551.0215303709865;4596.17268891596;4597.908041839144;4672.182368085571;4688.9531104689195;1964.2143142743016;2036.4501584572083;2067.338451695473;2073.315805784088;2079.6984437256515;912.6577533424966;926.5228407370209;982.1013772398319;1010.9191264698807;1013.4679293371039;16516.256768445448;20473.771573705624;20595.07322170506;20855;20914;1021.1626466297565;1021.3463383434607;1032.3135115148493;1039.599754094679;1044.6709286574858;9433.764155896157;11044.33733975964;11050.115990720724;11052.834207486894;11130.777384452265;552067;560491;655395;668111;677753;109635;140186;141917;143712.98189142914;147369.26315368354;902.8284625921054;963.393062370702;1049.3399232944448;1050.3907733514543;1056.170905838928;13170.275634840176;16999;17324.30702771875;18209.18058687389;18769.530761731065;52192.73903630458;53154;53235.93528129493;53513.464865352405;56149;75271.62364188144;78496.60751696205;78877.54185259418;81152.78270826061;82350;8227.506349619041;8241.711540096068;8248.381371397048;8254.793630159294;8289.751307460785;9209.493477858781;12033.939830300793;12656.557020504239;13060.804087938499;13063.934680326538;10791.136709063414;10798.73003174927;10947;11097.38964356968;11135.053520450852;10016.799664006534;10504.42225677595;10792.56829726802;11051.889481105087;11309.830352544883;10702;11065.391403472886;11235.494402751732;11406.258593191416;11532.962033417032;7832.099308579586;8250.092489826235;8264.793380165544;8383.144126971652;8605.95697021511;8237;10271.435071071162;11200.38397888124;11256.380899050631;11599.594014209462 20:31:34 INFO - PROCESS | 1667 | |3;mootools.html;1630.0627139394846;1656.4450908945507;1933.5746135850109;2016.3547664747277;2065.7004734313537;8299.460535065216;8958.776030599221;9249.260059195265;9429.198518125959;9474.336796424244;9018.233450156727;9112.589933452993;9123.224525915306;9187.724368268962;9207.585658645361;2434.221049264236;2562.5131225067175;2583.3025083227517;2586.8706564671784;2600.0899685110153;2209.668549717539;2522.4576716006054;2599.805014623901;2606.5438548254074;2609.0476975903753;2559.1554786920365;2581.1095172165665;2594.987025064872;2605.296569926119;2620.8296460729994;2566.2557858221094;2568.922932312043;2582.4705935283223;2603.947921041578;2609.425926296231;2147.3450597567735;2579.6646435963394;2586.935326616831;2600.5709058005405;2616.7775739062204;9337.906620933773;9372.67195648156;9380.202682771973;9406.059394060607;9408.623655053789;5699.145128230757;5715.085586306171;5764.07774756037;5930.584859059867;5933.970330148321;3704.759190652599;3783.05423644089;3785.3564893967814;3852.499175107218;3881.5536213335263;1064.5741703318656;1083.1497274639448;1087;1091.0889407344876;1124.8256520239377;12289.631311060682;12639.49442022318;12640.620781376574;12711.364431778375;12888.097833151684;4206.74759514424;5100.285959965608;5214.582833373321;5222.21666749983;5237.319148510669;10494.68515944523;10494.895051049545;10766;10779.67660970172;10841.891581084246;5667.858303542444;5705.058665320259;5851.122331650201;5929.14027466015;5935.614185077956;4717.339572459859;5135.101357262464;5250.317458730341;5259.737013149327;5324.9733751331;4278.72188307759;4334.696571239983;4356.455443069616;4378.8905277367685;4401.911961760747;1423.195894319706;1439.6832696806687;1442.4086124688827;1444.7471692453778;1468.5080498033064;816.6406781016334;872.2803686958158;957.3107362698985;974.6637410093506;976.0776066616979;5043;5842.269716285465;5942.405759424023;6084.300305464928;6141.662208578571;472.26326929989324;474.8789058790056;479.7457347605775;479.92561153021336;481.771482719065;3890.533136023695;3894.727369084137;3921.490206273166;3974.046228905042;4042.0299128209017;11150.609728659458;11371.943140284246;11493.77012459746;11519.654410367702;11540.538378464767;10678.412687302272;11251.662450126509;11262.324260544394;11317.83023254652;11331.660050198507;7335.376492998155;8005.759827205193;8213.726872334797;8240.258376746002;8584.05575386707;5947.851303717442;6037.275526936795;6045.848853778691;6056.515478761777;6158.630482171084;9659.46872921996;9966.750831229278;10038.64864729731;10088.495575221063;10096.747581310527;9738.805223895624;9949.353292035994;10173.847392288973;10252.179825614083;10253.692389228336;7119.928800711927;7586.317231449196;7793.610319484116;7797.142314345531;7801.531908085533;8496.872546911678;8562.828743425222;8582.871256931276;8645.351598630003;8657.437266577652;6524.380183882524;7183.52737688783;7528.698852046076;7658.425618078778;7865.724699635485;7484.32641062307;7510.924890751023;7513.8872916907385;7578.545287282781;7595.202503737028;7201.279872012757;7232.276772322725;7238.6380680966795;7341.74303899361;7361.742339018108;4916.631252655993;4978.775955082103;4994.725290109079;5057.0138822929175;5068.087744206078;4982.825601104089;5026.497350265091;5043.9747801260755;5133.486651334837;5173.586113110867 20:31:34 INFO - PROCESS | 1667 | |4;prototype.html;294.75829819547965;322.4518318857942;342.86456849544413;344.87756846319564;346.7832604622111;6738.52830301879;6871.896921546181;6884.139482564673;6900.75847345343;6972.965135174323;6892.483063770224;6921.480888933337;6945.617991010492;7150.678219480123;7192.136943566779;4500.054988452429;4876.2685597160535;5152.227165925123;5164.2253661950635;5174.379074511064;5146.816232266581;5159.097157997354;5160.380754309469;5193.246979188034;5204.947950520503;5087.720175390352;5092.185250359943;5103.438621751604;5110.897782044357;5119.897602047957;4812.639052071108;5023.824166154167;5025.824096156617;5088.211327244283;5091.66904151229;4228.112096459748;4249.405083288342;4255.55316691746;4256.425382573344;4286.292761694317;5276.287701160371;6610.975298828689;6631.834204144887;6680.966595166993;6681.899771503431;4213.325867861127;4345.152695224432;4523.095380923795;5938.257717785277;5968.940310596925;7415.18432972378;7429.739959101459;7432.108147022392;7457.888131678029;7482.513636613658;4587.564181402761;4773.594244489223;4785.832495862663;4794.904101917942;4796.856094317176;7874.960625196894;7879.212078792132;7933.365330773582;7945.523268603844;7953.4432589718745;4834.395700537433;4843.6367272454;4862;4867.586255168279;4891.877703057381;4930.556249937451;4944.505549445027;4967.850964471072;4971.130052240844;4972.577330926912;5941.643501389931;5980.970095149583;5982.461578457873;5992.760289588367;5998.340182579913;7231.096112985877;7525.623718814147;7538.2838630331125;7550.471466997257;7599.4680372373405;1446.4792674637122;1691.9830801691826;1693.6189357394735;1704.2160606121074;1715.5025042737466;1006.4967516241879;1057.9153667706564;1072.9302595331278;1073.8067147913293;1099.9230053896151;6946.8610627788175;6981.1622605286675;6990.685419156151;6991.23096459389;7015.719371225196;7648.311651951351;7669.5398276103615;7674.654640541189;7676.309132178131;7682.577458239739;7019.8596028079155;7028.508004439743;7037.19072306681;7037.437005039585;7098.964505177544;3987.80060996949;4054.108096218827;4067.51189857219;4100.200460910094;4125.876223713293;7980.640871160812;7981.08217554977;8000.399970002273;8043.879341809878;8083.555404452812;7909.683612655429;7915.287624113857;7926.9603651982525;7929.32600728933;7974.322182614426;8034.758957231293;8038.075621303508;8053.718119865894;8056.315213206826;8059.43583949118;6826.941824017285;7047.823804404726;7731.453709258059;7750.0699916010435;7754.961225193838;7478.551286922802;7525.285097915689;7530.021097257321;7545.396368290633;7585.16563178061;8022.438429309892;8022.638981245741;8032.317253033558;8033.678652854054;8040.758777236692;3981.92036159281;4863.586595139312;4873.805047798049;4878.975605121952;4888.36451261348;7045.506814522934;7521.962390188014;7709.421793365632;7779;7871.370290376642;6025.367336429612;6788.389044985975;7566.583837888969;7592.8481430369975;7625.885611715939;7570.205128461433;7581.658825352762;7591.089069311718;7604.391648667983;7619.504732192389;6045.75816967334;7292.124945006633;7380.372668323253;7401.629918504161;7432.6283685814415;6693.9624358224555;6968.3728464438445;7523.924760752541;7555.357794587521;7570.280823321776;7065.258147894397;7238.782836514913;7444.590547519721;7475.289847464483;7489.775306740807 20:31:34 INFO - PROCESS | 1667 | |5;yui.html;692.9930700692993;714.9285071492851;719.7121151539384;744.4453881858014;750.4634186556611;15391.769123463144;15457.536273911772;15608.531744047697;15611.375544978187;15666.608334791636;12182.939085304582;16268.186590670479;16297.83702162978;16321.347146114142;16368.590785230375;769.7960040589248;946.8485042393236;952.4808979106404;959.7744530035436;962.210986990668;944.4616568555925;956.5026186383077;965.6475386483918;965.8647789309503;974.1768205866032;985.0051448037498;1009.0615727373539;1014.0265345268551;1014.4319181258481;1017.5726194998082;978.7308490165261;1001.689476262361;1002.0080120680547;1007.7833265847842;1011.1405305490312;730.5105579261907;732.9047223860864;735.0995031086876;736.9005184300105;742.7808796405074;15490.380384784596;15526.767098493532;15557.844421555752;16042.5989350266;16076.196190190562;12905.741885162244;12945.093843430963;13084.084114112016;13097.083204175711;13159;10161.085502304828;10378.532966016548;10390.168786497137;10409.323393979443;10441.68674939753;3463.1169051891607;3515.8769443069627;3528.558930133733;3657;3674.761140525884;81500.59249703772;81681.18318816795;82119.9999999994;82469.58765206195;86878.56560717219;9409.341346105844;9502.857457138149;9526.714198574055;9833.26250531213;10358.274920755626;21248.575028499345;21256.468588285108;21924.780752192593;21939.561208775736;21955.451113721967;7461.813454663677;7520.059992500937;7572.20491848348;7612.733554325572;7657.119431265364;4155.10665206982;4155.58444155582;4202.600752928528;4217.536071032246;4282.935755963663;3738.289724952305;3770.5098337215986;3782.867599634055;3825.2158307547443;3851.306764782366;666.9233038200572;682.331315310998;688.834679676874;694.2259380790483;695.8726862482811;504.2537045173164;557.6208178438619;607.2955371768727;611.3641812514935;643.9195100612424;8303.252707256375;8306.54314012735;8365.665373385118;8589.312854971588;8686.348523860735;563.495671374126;579.8840231953626;611.248164757351;613.2702084519408;616.7841255560518;3909.980450097731;3961.1285517186748;3975.6024397560013;4092.5293591237387;4094.4975838686323;65099;68182.63634727278;87350;91596.16807663809;93840.12319753566;61760;76558.61720691361;79210.81183782133;79615.60192199118;82731.7590236147;53934.92130157375;68608.97086543706;70822;71103.93344099843;71974;7848.882266765889;8038.87941680887;8075.3135983439715;8084.717034903751;8228.136045715353;41367.58632413638;48409.75795121002;50190.99236030664;50545.73635659138;51459.48540514697;53548.92902142013;64620.35379646144;66339.66830165818;69359.30640693528;70095;9356.48539330316;9398.543225800013;10111.443870587189;10525.105366043972;10945.179111566506;11946.820797688215;11986.880131198577;12241.265524068229;12242.204256723284;12284.508619655113;11326.37704926204;11522.193446459003;11634.301941883514;11895.76208475843;11918.642440726791;11324.150688698215;11412.201145920038;11545.595904143314;11767.941160294144;11826.264261833176;11210.943945280547;11475.483603237708;11539.961403473728;11604.825927610924;11812.645620631394;9642.987486313836;9723.387257839082;9737.17234035115;9771.218302535923;9781.755456113655;9548.02739712348;9627.085426884434;9714.376799466114;9861.309708320348;10046.24653151002 20:31:34 INFO - PROCESS | 1667 | __end_tp_report 20:31:34 INFO - PROCESS | 1667 | __start_cc_report 20:31:34 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,393 20:31:34 INFO - PROCESS | 1667 | __end_cc_report 20:31:34 INFO - PROCESS | 1667 | __startTimestamp1468899094854__endTimestamp 20:31:34 INFO - PROCESS | 1667 | 20:31:34 INFO - PROCESS | 1667 | ------- Summary: start ------- 20:31:34 INFO - PROCESS | 1667 | Number of tests: 6 20:31:34 INFO - PROCESS | 1667 | 20:31:34 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:6048.91 Median:6285.65 stddev:678.80 (10.8%) stddev-sans-first:641.38 20:31:34 INFO - PROCESS | 1667 | Values: 3139.8 3678.1 3712.8 3715.5 3742.6 5879.0 6139.1 6149.8 6180.0 6192.4 4425.4 6021.3 6106.6 6111.3 6185.7 5474.5 5500.4 5523.0 5571.6 5622.4 5495.4 5553.7 5576.8 5588.6 5665.0 5554.1 5558.7 5572.1 5575.8 5586.7 5550.3 5554.4 5575.0 5581.9 5595.4 5484.6 5537.8 5550.3 5569.4 5587.6 5910.6 5965.3 5984.8 6108.8 6142.4 6437.4 6482.7 6482.9 6500.4 6504.3 6537.0 6560.8 6581.2 6585.8 6602.4 6116.5 6153.7 6180.8 6209.1 6222.9 6640.1 6715.6 6720.1 6724.1 6737.8 6375.5 6416.2 6417.2 6418.4 6439.7 6404.4 6441.6 6472.1 6503.5 6615.7 6434.6 6471.1 6479.3 6485.6 6486.9 4769.9 5220.5 5425.5 6485.4 6491.3 5102.4 5143.6 5200.2 5222.8 5272.0 4655.6 4662.4 4663.2 4675.1 4726.3 5997.9 6153.0 6193.0 6232.1 6271.9 6443.5 6543.9 6568.2 6601.8 6657.9 6276.9 6289.1 6292.1 6306.7 6317.7 5678.9 5749.2 5796.5 5806.4 5807.4 6738.0 6751.3 6766.5 6772.1 6773.1 6567.5 6588.8 6593.2 6614.6 6624.8 6620.1 6694.4 6780.6 6796.5 6802.9 6483.2 6488.8 6513.0 6527.7 6541.5 6535.1 6626.6 6631.5 6638.8 6655.2 6277.6 6354.6 6357.7 6374.3 6384.0 6357.8 6373.4 6378.1 6383.3 6397.9 5876.6 6201.1 6275.2 6285.9 6291.7 5997.1 6216.1 6274.6 6357.2 6363.5 6248.4 6285.7 6288.1 6292.7 6297.7 20:31:34 INFO - PROCESS | 1667 | 20:31:34 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:67136.19 Median:38938.22 stddev:147868.98 (379.8%) stddev-sans-first:148199.26 20:31:34 INFO - PROCESS | 1667 | Values: 542.4 581.8 583.5 606.9 675.7 34013.8 39372.6 39398.8 39550.2 39559.8 41270.8 41626.2 41663.4 41749.7 41784.0 8285.3 9457.6 9569.9 9693.9 9702.2 9691.2 9805.1 9826.4 9841.9 9913.0 9835.0 9916.7 9929.7 9938.6 9971.4 9813.0 9868.5 9897.6 9928.4 9956.6 9681.8 9748.2 9759.6 9780.5 9792.5 39184.4 39369.4 39565.8 39595.2 39655.0 3090.8 3293.6 3379.0 3405.8 3606.2 24036.4 26837.3 28678.6 29889.6 30349.8 2759.5 2784.3 2799.9 2806.5 2816.7 387865.1 434722.0 459763.0 462736.0 463409.0 37327.6 38118.6 50847.5 60870.0 61706.0 30593.0 35966.0 36448.5 36506.0 37019.8 15823.0 15989.4 16416.3 16546.6 16561.4 11938.2 13967.6 14051.9 14167.5 14241.9 8398.3 8452.9 8494.0 8526.0 8566.0 3543.9 3557.4 3569.8 3579.2 3580.6 1043.9 1065.2 1106.8 1203.2 1211.7 30377.5 30425.7 30652.4 30823.4 31142.2 1068.8 1196.4 1199.9 1243.9 1291.6 12339.7 15152.5 15397.3 15513.9 15974.8 620695.0 621877.0 627651.0 628699.0 630766.5 59407.7 60657.4 60870.4 61477.0 61800.4 1494.2 1509.6 1510.9 1521.1 1522.2 29760.6 30497.7 30538.4 30634.1 30834.0 53721.0 53996.2 54009.0 54194.0 54232.7 570646.0 572624.0 572911.0 574820.0 575974.0 26483.7 27704.4 27852.3 27947.3 28375.9 46572.8 46623.8 48192.0 48539.3 48582.0 38887.7 38973.0 39080.6 39436.0 39874.2 31002.7 38428.8 38594.0 38903.4 38976.8 38203.4 38720.0 39626.0 40354.6 40553.4 31728.7 33847.5 33900.7 33940.0 34218.5 24445.5 26604.7 26662.1 26993.6 27044.7 20:31:34 INFO - PROCESS | 1667 | 20:31:34 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:35988.96 Median:21690.34 stddev:104292.95 (480.8%) stddev-sans-first:104551.19 20:31:34 INFO - PROCESS | 1667 | Values: 348.7 407.9 413.6 421.2 424.3 16104.4 20884.4 21652.0 21750.9 21930.5 21268.6 21373.5 21558.6 21653.8 21726.9 5760.6 5838.9 6066.1 6120.1 6128.8 5951.3 5953.0 5958.6 6044.2 6061.5 5869.7 5896.6 5923.1 5985.6 6099.8 5267.6 5875.2 5915.9 6004.8 6034.5 5144.9 5235.4 5265.1 5267.8 5286.8 20835.1 21551.5 26571.8 26982.6 27304.6 2231.9 2266.0 2513.9 2515.3 2589.6 15062.4 15123.9 15460.5 15607.8 15657.7 1564.0 1798.2 1850.5 1867.8 1883.0 112267.0 113254.4 113534.9 116337.0 118488.6 11126.3 11561.9 11677.5 11744.0 12155.5 14368.6 14442.3 14474.3 14579.9 14596.9 8427.9 8767.8 8769.4 8896.7 8903.4 8872.9 8978.5 8994.5 9057.5 9124.7 4551.0 4596.2 4597.9 4672.2 4689.0 1964.2 2036.5 2067.3 2073.3 2079.7 912.7 926.5 982.1 1010.9 1013.5 16516.3 20473.8 20595.1 20855.0 20914.0 1021.2 1021.3 1032.3 1039.6 1044.7 9433.8 11044.3 11050.1 11052.8 11130.8 552067.0 560491.0 655395.0 668111.0 677753.0 109635.0 140186.0 141917.0 143713.0 147369.3 902.8 963.4 1049.3 1050.4 1056.2 13170.3 16999.0 17324.3 18209.2 18769.5 52192.7 53154.0 53235.9 53513.5 56149.0 75271.6 78496.6 78877.5 81152.8 82350.0 8227.5 8241.7 8248.4 8254.8 8289.8 9209.5 12033.9 12656.6 13060.8 13063.9 10791.1 10798.7 10947.0 11097.4 11135.1 10016.8 10504.4 10792.6 11051.9 11309.8 10702.0 11065.4 11235.5 11406.3 11533.0 7832.1 8250.1 8264.8 8383.1 8606.0 8237.0 10271.4 11200.4 11256.4 11599.6 20:31:34 INFO - PROCESS | 1667 | 20:31:34 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5953.01 Median:4988.78 stddev:3338.78 (66.9%) stddev-sans-first:3332.34 20:31:34 INFO - PROCESS | 1667 | Values: 1630.1 1656.4 1933.6 2016.4 2065.7 8299.5 8958.8 9249.3 9429.2 9474.3 9018.2 9112.6 9123.2 9187.7 9207.6 2434.2 2562.5 2583.3 2586.9 2600.1 2209.7 2522.5 2599.8 2606.5 2609.0 2559.2 2581.1 2595.0 2605.3 2620.8 2566.3 2568.9 2582.5 2603.9 2609.4 2147.3 2579.7 2586.9 2600.6 2616.8 9337.9 9372.7 9380.2 9406.1 9408.6 5699.1 5715.1 5764.1 5930.6 5934.0 3704.8 3783.1 3785.4 3852.5 3881.6 1064.6 1083.1 1087.0 1091.1 1124.8 12289.6 12639.5 12640.6 12711.4 12888.1 4206.7 5100.3 5214.6 5222.2 5237.3 10494.7 10494.9 10766.0 10779.7 10841.9 5667.9 5705.1 5851.1 5929.1 5935.6 4717.3 5135.1 5250.3 5259.7 5325.0 4278.7 4334.7 4356.5 4378.9 4401.9 1423.2 1439.7 1442.4 1444.7 1468.5 816.6 872.3 957.3 974.7 976.1 5043.0 5842.3 5942.4 6084.3 6141.7 472.3 474.9 479.7 479.9 481.8 3890.5 3894.7 3921.5 3974.0 4042.0 11150.6 11371.9 11493.8 11519.7 11540.5 10678.4 11251.7 11262.3 11317.8 11331.7 7335.4 8005.8 8213.7 8240.3 8584.1 5947.9 6037.3 6045.8 6056.5 6158.6 9659.5 9966.8 10038.6 10088.5 10096.7 9738.8 9949.4 10173.8 10252.2 10253.7 7119.9 7586.3 7793.6 7797.1 7801.5 8496.9 8562.8 8582.9 8645.4 8657.4 6524.4 7183.5 7528.7 7658.4 7865.7 7484.3 7510.9 7513.9 7578.5 7595.2 7201.3 7232.3 7238.6 7341.7 7361.7 4916.6 4978.8 4994.7 5057.0 5068.1 4982.8 5026.5 5044.0 5133.5 5173.6 20:31:34 INFO - PROCESS | 1667 | 20:31:34 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:6046.65 Median:6933.55 stddev:1983.32 (28.6%) stddev-sans-first:1941.33 20:31:34 INFO - PROCESS | 1667 | Values: 294.8 322.5 342.9 344.9 346.8 6738.5 6871.9 6884.1 6900.8 6973.0 6892.5 6921.5 6945.6 7150.7 7192.1 4500.1 4876.3 5152.2 5164.2 5174.4 5146.8 5159.1 5160.4 5193.2 5204.9 5087.7 5092.2 5103.4 5110.9 5119.9 4812.6 5023.8 5025.8 5088.2 5091.7 4228.1 4249.4 4255.6 4256.4 4286.3 5276.3 6611.0 6631.8 6681.0 6681.9 4213.3 4345.2 4523.1 5938.3 5968.9 7415.2 7429.7 7432.1 7457.9 7482.5 4587.6 4773.6 4785.8 4794.9 4796.9 7875.0 7879.2 7933.4 7945.5 7953.4 4834.4 4843.6 4862.0 4867.6 4891.9 4930.6 4944.5 4967.9 4971.1 4972.6 5941.6 5981.0 5982.5 5992.8 5998.3 7231.1 7525.6 7538.3 7550.5 7599.5 1446.5 1692.0 1693.6 1704.2 1715.5 1006.5 1057.9 1072.9 1073.8 1099.9 6946.9 6981.2 6990.7 6991.2 7015.7 7648.3 7669.5 7674.7 7676.3 7682.6 7019.9 7028.5 7037.2 7037.4 7099.0 3987.8 4054.1 4067.5 4100.2 4125.9 7980.6 7981.1 8000.4 8043.9 8083.6 7909.7 7915.3 7927.0 7929.3 7974.3 8034.8 8038.1 8053.7 8056.3 8059.4 6826.9 7047.8 7731.5 7750.1 7755.0 7478.6 7525.3 7530.0 7545.4 7585.2 8022.4 8022.6 8032.3 8033.7 8040.8 3981.9 4863.6 4873.8 4879.0 4888.4 7045.5 7522.0 7709.4 7779.0 7871.4 6025.4 6788.4 7566.6 7592.8 7625.9 7570.2 7581.7 7591.1 7604.4 7619.5 6045.8 7292.1 7380.4 7401.6 7432.6 6694.0 6968.4 7523.9 7555.4 7570.3 7065.3 7238.8 7444.6 7475.3 7489.8 20:31:34 INFO - PROCESS | 1667 | 20:31:34 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:17929.80 Median:27246.27 stddev:24629.12 (90.4%) stddev-sans-first:24664.21 20:31:34 INFO - PROCESS | 1667 | Values: 693.0 714.9 719.7 744.4 750.5 15391.8 15457.5 15608.5 15611.4 15666.6 12182.9 16268.2 16297.8 16321.3 16368.6 769.8 946.8 952.5 959.8 962.2 944.5 956.5 965.6 965.9 974.2 985.0 1009.1 1014.0 1014.4 1017.6 978.7 1001.7 1002.0 1007.8 1011.1 730.5 732.9 735.1 736.9 742.8 15490.4 15526.8 15557.8 16042.6 16076.2 12905.7 12945.1 13084.1 13097.1 13159.0 10161.1 10378.5 10390.2 10409.3 10441.7 3463.1 3515.9 3528.6 3657.0 3674.8 81500.6 81681.2 82120.0 82469.6 86878.6 9409.3 9502.9 9526.7 9833.3 10358.3 21248.6 21256.5 21924.8 21939.6 21955.5 7461.8 7520.1 7572.2 7612.7 7657.1 4155.1 4155.6 4202.6 4217.5 4282.9 3738.3 3770.5 3782.9 3825.2 3851.3 666.9 682.3 688.8 694.2 695.9 504.3 557.6 607.3 611.4 643.9 8303.3 8306.5 8365.7 8589.3 8686.3 563.5 579.9 611.2 613.3 616.8 3910.0 3961.1 3975.6 4092.5 4094.5 65099.0 68182.6 87350.0 91596.2 93840.1 61760.0 76558.6 79210.8 79615.6 82731.8 53934.9 68609.0 70822.0 71103.9 71974.0 7848.9 8038.9 8075.3 8084.7 8228.1 41367.6 48409.8 50191.0 50545.7 51459.5 53548.9 64620.4 66339.7 69359.3 70095.0 9356.5 9398.5 10111.4 10525.1 10945.2 11946.8 11986.9 12241.3 12242.2 12284.5 11326.4 11522.2 11634.3 11895.8 11918.6 11324.2 11412.2 11545.6 11767.9 11826.3 11210.9 11475.5 11540.0 11604.8 11812.6 9643.0 9723.4 9737.2 9771.2 9781.8 9548.0 9627.1 9714.4 9861.3 10046.2 20:31:34 INFO - PROCESS | 1667 | -------- Summary: end -------- 20:31:34 INFO - PROCESS | 1667 | 20:31:35 INFO - TEST-INFO | 1667: exit 0 20:31:35 INFO - TEST-OK | dromaeo_css | took 1110233ms 20:31:35 INFO - TEST-START | kraken 20:31:35 INFO - operating with platform_type : mac_ 20:31:35 INFO - Initialising browser for kraken test... 20:31:35 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpGMqkTQ/profile http://localhost:49271/getInfo.html) 20:31:37 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 20:31:37 INFO - PROCESS | 1680 | colorDepth:24 20:31:37 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 20:31:37 INFO - PROCESS | 1680 | __metrics 20:31:38 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 20:31:38 INFO - TEST-INFO | 1680: exit 0 20:31:38 INFO - Browser initialized. 20:31:38 INFO - Running cycle 1/1 for kraken test... 20:31:38 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpGMqkTQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:31:50 INFO - PROCESS | 1684 | RSS: Main: 170999808 20:31:50 INFO - PROCESS | 1684 | 20:31:53 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 20:31:54 INFO - PROCESS | 1684 | RSS: Main: 183582720 20:31:54 INFO - PROCESS | 1684 | 20:31:56 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 20:31:57 INFO - PROCESS | 1684 | RSS: Main: 192344064 20:31:57 INFO - PROCESS | 1684 | 20:32:00 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 20:32:01 INFO - PROCESS | 1684 | RSS: Main: 195911680 20:32:01 INFO - PROCESS | 1684 | 20:32:03 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 20:32:04 INFO - PROCESS | 1684 | RSS: Main: 196120576 20:32:04 INFO - PROCESS | 1684 | 20:32:06 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:32:06 INFO - PROCESS | 1684 | RSS: Main: 196489216 20:32:06 INFO - PROCESS | 1684 | 20:32:09 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 20:32:10 INFO - PROCESS | 1684 | RSS: Main: 198557696 20:32:10 INFO - PROCESS | 1684 | 20:32:13 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 20:32:13 INFO - PROCESS | 1684 | RSS: Main: 198598656 20:32:13 INFO - PROCESS | 1684 | 20:32:16 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 20:32:17 INFO - PROCESS | 1684 | RSS: Main: 198602752 20:32:17 INFO - PROCESS | 1684 | 20:32:18 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:32:19 INFO - PROCESS | 1684 | RSS: Main: 197693440 20:32:19 INFO - PROCESS | 1684 | 20:32:21 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:32:21 INFO - PROCESS | 1684 | RSS: Main: 197746688 20:32:21 INFO - PROCESS | 1684 | 20:32:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:32:24 INFO - PROCESS | 1684 | RSS: Main: 198025216 20:32:24 INFO - PROCESS | 1684 | 20:32:27 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:32:27 INFO - PROCESS | 1684 | RSS: Main: 198119424 20:32:27 INFO - PROCESS | 1684 | 20:32:30 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:32:31 INFO - PROCESS | 1684 | RSS: Main: 198094848 20:32:31 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 20:32:33 INFO - PROCESS | 1684 | RSS: Main: 200089600 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | __start_tp_report 20:32:33 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 20:32:33 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 20:32:33 INFO - PROCESS | 1684 | |i|pagename|runs| 20:32:33 INFO - PROCESS | 1684 | |0;ai-astar;167;161;143;118;118;130;115;118;115;115 20:32:33 INFO - PROCESS | 1684 | |1;audio-beat-detection;168;151;177;158;132;137;122;150;156;122 20:32:33 INFO - PROCESS | 1684 | |2;audio-dft;194;194;190;197;197;195;203;197;202;199 20:32:33 INFO - PROCESS | 1684 | |3;audio-fft;67;68;83;137;82;78;59;83;126;56 20:32:33 INFO - PROCESS | 1684 | |4;audio-oscillator;78;80;127;77;78;85;111;81;78;113 20:32:33 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;109;109;90;78;121;128;136;85;89;85 20:32:33 INFO - PROCESS | 1684 | |6;imaging-darkroom;150;94;93;94;93;95;95;98;93;93 20:32:33 INFO - PROCESS | 1684 | |7;imaging-desaturate;91;86;89;90;90;90;90;90;114;121 20:32:33 INFO - PROCESS | 1684 | |8;json-parse-financial;61;61;64;65;65;66;65;80;61;59 20:32:33 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;62;66;71;96;109;93;70;65;61;78 20:32:33 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;82;78;80;82;80;79;81;81;90;87 20:32:33 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;128;127;125;126;128;138;151;130;150;140 20:32:33 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;167;208;222;213;168;164;167;168;166;166 20:32:33 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;60;92;97;94;97;74;68;71;70;70 20:32:33 INFO - PROCESS | 1684 | __end_tp_report 20:32:33 INFO - PROCESS | 1684 | __start_cc_report 20:32:33 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1056 20:32:33 INFO - PROCESS | 1684 | __end_cc_report 20:32:33 INFO - PROCESS | 1684 | __startTimestamp1468899153592__endTimestamp 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | ------- Summary: start ------- 20:32:33 INFO - PROCESS | 1684 | Number of tests: 14 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:130.00 Median:124.00 stddev:20.02 (16.1%) stddev-sans-first:16.14 20:32:33 INFO - PROCESS | 1684 | Values: 167.0 161.0 143.0 118.0 118.0 130.0 115.0 118.0 115.0 115.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:153.50 stddev:18.68 (12.2%) stddev-sans-first:18.26 20:32:33 INFO - PROCESS | 1684 | Values: 168.0 151.0 177.0 158.0 132.0 137.0 122.0 150.0 156.0 122.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:196.80 Median:197.00 stddev:3.88 (2.0%) stddev-sans-first:3.98 20:32:33 INFO - PROCESS | 1684 | Values: 194.0 194.0 190.0 197.0 197.0 195.0 203.0 197.0 202.0 199.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:83.90 Median:73.00 stddev:27.02 (37.0%) stddev-sans-first:27.95 20:32:33 INFO - PROCESS | 1684 | Values: 67.0 68.0 83.0 137.0 82.0 78.0 59.0 83.0 126.0 56.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:78.00 stddev:18.68 (23.9%) stddev-sans-first:19.23 20:32:33 INFO - PROCESS | 1684 | Values: 78.0 80.0 127.0 77.0 78.0 85.0 111.0 81.0 78.0 113.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:103.00 Median:81.50 stddev:20.41 (25.0%) stddev-sans-first:21.53 20:32:33 INFO - PROCESS | 1684 | Values: 109.0 109.0 90.0 78.0 121.0 128.0 136.0 85.0 89.0 85.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:94.00 stddev:17.71 (18.8%) stddev-sans-first:1.64 20:32:33 INFO - PROCESS | 1684 | Values: 150.0 94.0 93.0 94.0 93.0 95.0 95.0 98.0 93.0 93.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:90.00 stddev:11.99 (13.3%) stddev-sans-first:12.63 20:32:33 INFO - PROCESS | 1684 | Values: 91.0 86.0 89.0 90.0 90.0 90.0 90.0 90.0 114.0 121.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:5.87 (9.0%) stddev-sans-first:6.07 20:32:33 INFO - PROCESS | 1684 | Values: 61.0 61.0 64.0 65.0 65.0 66.0 65.0 80.0 61.0 59.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:77.10 Median:70.50 stddev:16.58 (23.5%) stddev-sans-first:16.66 20:32:33 INFO - PROCESS | 1684 | Values: 62.0 66.0 71.0 96.0 109.0 93.0 70.0 65.0 61.0 78.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:3.71 (4.6%) stddev-sans-first:3.94 20:32:33 INFO - PROCESS | 1684 | Values: 82.0 78.0 80.0 82.0 80.0 79.0 81.0 81.0 90.0 87.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:134.00 stddev:9.88 (7.4%) stddev-sans-first:10.21 20:32:33 INFO - PROCESS | 1684 | Values: 128.0 127.0 125.0 126.0 128.0 138.0 151.0 130.0 150.0 140.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:168.00 stddev:23.34 (13.9%) stddev-sans-first:24.21 20:32:33 INFO - PROCESS | 1684 | Values: 167.0 208.0 222.0 213.0 168.0 164.0 167.0 168.0 166.0 166.0 20:32:33 INFO - PROCESS | 1684 | 20:32:33 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.30 Median:83.00 stddev:14.04 (16.9%) stddev-sans-first:13.04 20:32:33 INFO - PROCESS | 1684 | Values: 60.0 92.0 97.0 94.0 97.0 74.0 68.0 71.0 70.0 70.0 20:32:33 INFO - PROCESS | 1684 | -------- Summary: end -------- 20:32:33 INFO - PROCESS | 1684 | 20:32:34 INFO - TEST-INFO | 1684: exit 0 20:32:34 INFO - TEST-OK | kraken | took 58946ms 20:32:34 INFO - SUITE-END | took 1169s 20:32:34 INFO - Completed test suite (00:19:29) 20:32:34 INFO - javascript benchmark 20:32:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.8430078496085, 3678.1356381250403, 3712.777233365998, 3715.4798328234033, 3742.644448777367, 5878.970605146968, 6139.079138129283, 6149.754009839607, 6180.0, 6192.380761923811, 4425.430305442243, 6021.277446706401, 6106.572539922207, 6111.297200821907, 6185.721642526086, 5474.507294343508, 5500.42245564216, 5523.005858945408, 5571.609987300891, 5622.409646987069, 5495.422980587041, 5553.666779993193, 5576.776928922838, 5588.608797384185, 5665.008623490872, 5554.0835762099405, 5558.749856256478, 5572.080606699889, 5575.804846830361, 5586.748596313156, 5550.333959924795, 5554.444555544454, 5574.9721251393485, 5581.8604534886545, 5595.356533998602, 5484.588655850827, 5537.750801213955, 5550.333959924795, 5569.359523654791, 5587.636803607753, 5910.615809972338, 5965.3139888912465, 5984.760609575612, 6108.847278818021, 6142.385761423867, 6437.388448097423, 6482.7406903723795, 6482.870342593169, 6500.4474619657385, 6504.349565043505, 6536.986767051115, 6560.805461362673, 6581.21025476941, 6585.835354116185, 6602.40578347951, 6116.548817443993, 6153.723082461211, 6180.783672571529, 6209.130721698965, 6222.875542489125, 6640.103586015826, 6715.597064176165, 6720.059191713164, 6724.092247546519, 6737.831554211184, 6375.458086062644, 6416.197975253093, 6417.2299324081405, 6418.422341989243, 6439.710213040425, 6404.39158279972, 6441.581297215666, 6472.093906853044, 6503.544751867324, 6615.669216539154, 6434.64609446485, 6471.126397936312, 6479.319671434526, 6485.6108633482145, 6486.902696459557, 4769.9046019080115, 5220.477952204749, 5425.538829199483, 6485.44873685742, 6491.253505846888, 5102.36220472441, 5143.6399452037995, 5200.167973124282, 5222.843314700565, 5271.971965466697, 4655.580997710223, 4662.417197850269, 4663.183942810063, 4675.13510000651, 4726.3146843708155, 5997.880042399128, 6153.046277826944, 6193.0, 6232.065190221503, 6271.937280627135, 6443.454835340014, 6543.901841472381, 6568.244651865001, 6601.768938087144, 6657.900131498031, 6276.905846412307, 6289.0880822280515, 6292.056191571301, 6306.684665766693, 6317.747290108436, 5678.886422271531, 5749.1663708762835, 5796.5072968797285, 5806.44838740319, 5807.419258074243, 6738.0, 6751.291114433012, 6766.526343156129, 6772.119624448888, 6773.085633439521, 6567.507436942153, 6588.769393071219, 6593.241777195492, 6614.570052946543, 6624.768133115318, 6620.106285651375, 6694.430973367318, 6780.627065511247, 6796.490263230178, 6802.897956530557, 6483.157189565326, 6488.772892948724, 6513.0, 6527.738890444329, 6541.476681865344, 6535.117759102461, 6626.602403855784, 6631.469482441489, 6638.76764313266, 6655.23464801554, 6277.623342599459, 6354.618722876642, 6357.7139028742895, 6374.26695929974, 6383.96808015957, 6357.777477788255, 6373.426391624776, 6378.075179099097, 6383.265924418752, 6397.936020639734, 5876.588638795243, 6201.10084037803, 6275.184226050585, 6285.905711414241, 6291.685415729286, 5997.130416089555, 6216.067589861557, 6274.592151510137, 6357.237131544244, 6363.490920726238, 6248.375162483897, 6285.654289014148, 6288.056791481315, 6292.748290068346, 6297.685115744286], "value": 6007.341288931775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.4033563080611, 581.7847396463309, 583.4602992232184, 606.9453749162575, 675.739745374876, 34013.82993085034, 39372.60627393725, 39398.803005985, 39550.20899582007, 39559.80220098899, 41270.79364603173, 41626.167476650524, 41663.375049374285, 41749.74750757474, 41783.95540111499, 8285.295749861269, 9457.57440915157, 9569.856452153223, 9693.903060969405, 9702.17531509819, 9691.176250018756, 9805.117539421452, 9826.410415375065, 9841.852372214422, 9913.0, 9835.0, 9916.652917147901, 9929.702108936708, 9938.55276512555, 9971.351862128975, 9812.95093524535, 9868.506574671237, 9897.60409583623, 9928.404295742279, 9956.551955162035, 9681.789776277965, 9748.171405430547, 9759.609615615367, 9780.510974451248, 9792.510374481248, 39184.41223381652, 39369.40945885814, 39565.80217098925, 39595.20809583821, 39655.0, 3090.7990980586414, 3293.5883014623173, 3379.0, 3405.7786243894316, 3606.1525541497726, 24036.399090022715, 26837.32906677329, 28678.569821452696, 29889.551656725165, 30349.848250758827, 2759.503289407906, 2784.317842128671, 2799.9300017499727, 2806.480801051812, 2816.7183281671873, 387865.0606746976, 434722.0, 459763.0, 462736.0, 463409.0, 37327.62672373296, 38118.61881381151, 50847.47457576279, 60870.0, 61706.0, 30593.0, 35966.0, 36448.453273200925, 36506.0, 37019.814900925325, 15823.0, 15989.360425582847, 16416.261268242957, 16546.58633534147, 16561.42035028768, 11938.164328496921, 13967.580972570839, 14051.929740351234, 14167.504137355143, 14241.928790356189, 8398.286145677564, 8452.8732069019, 8494.023187333536, 8525.976882773983, 8566.014908285628, 3543.8936831895085, 3557.4308110702164, 3569.7501174917506, 3579.19468119671, 3580.606133325332, 1043.9008294212038, 1065.2436769893463, 1106.80630889594, 1203.1998720850536, 1211.660734994203, 30377.544336834966, 30425.69574304273, 30652.38695226083, 30823.38353232923, 31142.22144446407, 1068.834330678746, 1196.407778149804, 1199.8920097191294, 1243.9191452555556, 1291.560869304422, 12339.6915077122, 15152.545423637088, 15397.307121179574, 15513.922430387776, 15974.840251597569, 620695.0, 621877.0, 627651.0, 628699.0, 630766.5385019229, 59407.70296148578, 60657.39342606605, 60870.39129608736, 61477.0, 61800.381996179465, 1494.1782019889235, 1509.5848641623422, 1510.909345439277, 1521.1481570320657, 1522.2464879884308, 29760.553591696575, 30497.695023049484, 30538.389232215675, 30634.072944868276, 30834.0, 53721.0, 53996.190057148386, 54009.0, 54194.0, 54232.72883635556, 570646.0, 572624.0, 572911.0, 574820.0, 575974.0, 26483.735162648896, 27704.445911081264, 27852.30369240785, 27947.301317467227, 28375.858120709265, 46572.76713616546, 46623.76688116538, 48192.0, 48539.27191092066, 48582.0, 38887.73110244376, 38973.02567435837, 39080.609193907694, 39436.0, 39874.2025159501, 31002.68997309998, 38428.80785596054, 38594.0351491215, 38903.41644875386, 38976.830695079196, 38203.42694859635, 38720.0, 39626.009349766486, 40354.59645403508, 40553.391699125124, 31728.682713172573, 33847.49228761521, 33900.66099338975, 33940.0, 34218.48672269968, 24445.51108977846, 26604.733952660226, 26662.06682766094, 26993.595096073183, 27044.72955270501], "value": 18970.241111450534, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.72019687745967, 407.85317285777114, 413.61947008751946, 421.1555830559727, 424.2617844949788, 16104.436344727937, 20884.37346879594, 21651.99999999998, 21750.89124554377, 21930.4517387065, 21268.57462850742, 21373.465663358424, 21558.568828623418, 21653.783462165375, 21726.89136554315, 5760.596758226915, 5838.9124163137585, 6066.059760737093, 6120.081987701858, 6128.8467788305425, 5951.285845698522, 5952.970235148819, 5958.612690175125, 6044.153818465396, 6061.545384096188, 5869.735861886204, 5896.557758168155, 5923.111533270023, 5985.5810093293485, 6099.817005489843, 5267.578593712494, 5875.206847075676, 5915.911261331084, 6004.819855404323, 6034.5172386209215, 5144.922826157611, 5235.371755389339, 5265.131253343194, 5267.789288428458, 5286.841394758163, 20835.062422191037, 21551.461213469633, 26571.80426880795, 26982.5952610711, 27304.63476826151, 2231.854929429598, 2265.9546809063727, 2513.937151571207, 2515.320863366899, 2589.5597748382634, 15062.397504099823, 15123.924380378028, 15460.458883939009, 15607.843921560867, 15657.686846263012, 1563.9687206255926, 1798.1818272685896, 1850.5281153305955, 1867.7758668959675, 1882.9717554236697, 112267.0, 113254.43372783165, 113534.86465135326, 116337.0, 118488.63022739583, 11126.332420054823, 11561.88438115625, 11677.474513646906, 11744.0, 12155.5137794489, 14368.634979676914, 14442.33913100007, 14474.348654310581, 14579.927100364643, 14596.927015365067, 8427.915720842713, 8767.780805479786, 8769.38614297006, 8896.688615898413, 8903.421277616933, 8872.911270887338, 8978.461292322481, 8994.50530220831, 9057.547122643842, 9124.680636177834, 4551.0215303709865, 4596.17268891596, 4597.908041839144, 4672.182368085571, 4688.9531104689195, 1964.2143142743016, 2036.4501584572083, 2067.338451695473, 2073.315805784088, 2079.6984437256515, 912.6577533424966, 926.5228407370209, 982.1013772398319, 1010.9191264698807, 1013.4679293371039, 16516.256768445448, 20473.771573705624, 20595.07322170506, 20855.0, 20914.0, 1021.1626466297565, 1021.3463383434607, 1032.3135115148493, 1039.599754094679, 1044.6709286574858, 9433.764155896157, 11044.33733975964, 11050.115990720724, 11052.834207486894, 11130.777384452265, 552067.0, 560491.0, 655395.0, 668111.0, 677753.0, 109635.0, 140186.0, 141917.0, 143712.98189142914, 147369.26315368354, 902.8284625921054, 963.393062370702, 1049.3399232944448, 1050.3907733514543, 1056.170905838928, 13170.275634840176, 16999.0, 17324.30702771875, 18209.18058687389, 18769.530761731065, 52192.73903630458, 53154.0, 53235.93528129493, 53513.464865352405, 56149.0, 75271.62364188144, 78496.60751696205, 78877.54185259418, 81152.78270826061, 82350.0, 8227.506349619041, 8241.711540096068, 8248.381371397048, 8254.793630159294, 8289.751307460785, 9209.493477858781, 12033.939830300793, 12656.557020504239, 13060.804087938499, 13063.934680326538, 10791.136709063414, 10798.73003174927, 10947.0, 11097.38964356968, 11135.053520450852, 10016.799664006534, 10504.42225677595, 10792.56829726802, 11051.889481105087, 11309.830352544883, 10702.0, 11065.391403472886, 11235.494402751732, 11406.258593191416, 11532.962033417032, 7832.099308579586, 8250.092489826235, 8264.793380165544, 8383.144126971652, 8605.95697021511, 8237.0, 10271.435071071162, 11200.38397888124, 11256.380899050631, 11599.594014209462], "value": 9755.404568455366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1630.0627139394846, 1656.4450908945507, 1933.5746135850109, 2016.3547664747277, 2065.7004734313537, 8299.460535065216, 8958.776030599221, 9249.260059195265, 9429.198518125959, 9474.336796424244, 9018.233450156727, 9112.589933452993, 9123.224525915306, 9187.724368268962, 9207.585658645361, 2434.221049264236, 2562.5131225067175, 2583.3025083227517, 2586.8706564671784, 2600.0899685110153, 2209.668549717539, 2522.4576716006054, 2599.805014623901, 2606.5438548254074, 2609.0476975903753, 2559.1554786920365, 2581.1095172165665, 2594.987025064872, 2605.296569926119, 2620.8296460729994, 2566.2557858221094, 2568.922932312043, 2582.4705935283223, 2603.947921041578, 2609.425926296231, 2147.3450597567735, 2579.6646435963394, 2586.935326616831, 2600.5709058005405, 2616.7775739062204, 9337.906620933773, 9372.67195648156, 9380.202682771973, 9406.059394060607, 9408.623655053789, 5699.145128230757, 5715.085586306171, 5764.07774756037, 5930.584859059867, 5933.970330148321, 3704.759190652599, 3783.05423644089, 3785.3564893967814, 3852.499175107218, 3881.5536213335263, 1064.5741703318656, 1083.1497274639448, 1087.0, 1091.0889407344876, 1124.8256520239377, 12289.631311060682, 12639.49442022318, 12640.620781376574, 12711.364431778375, 12888.097833151684, 4206.74759514424, 5100.285959965608, 5214.582833373321, 5222.21666749983, 5237.319148510669, 10494.68515944523, 10494.895051049545, 10766.0, 10779.67660970172, 10841.891581084246, 5667.858303542444, 5705.058665320259, 5851.122331650201, 5929.14027466015, 5935.614185077956, 4717.339572459859, 5135.101357262464, 5250.317458730341, 5259.737013149327, 5324.9733751331, 4278.72188307759, 4334.696571239983, 4356.455443069616, 4378.8905277367685, 4401.911961760747, 1423.195894319706, 1439.6832696806687, 1442.4086124688827, 1444.7471692453778, 1468.5080498033064, 816.6406781016334, 872.2803686958158, 957.3107362698985, 974.6637410093506, 976.0776066616979, 5043.0, 5842.269716285465, 5942.405759424023, 6084.300305464928, 6141.662208578571, 472.26326929989324, 474.8789058790056, 479.7457347605775, 479.92561153021336, 481.771482719065, 3890.533136023695, 3894.727369084137, 3921.490206273166, 3974.046228905042, 4042.0299128209017, 11150.609728659458, 11371.943140284246, 11493.77012459746, 11519.654410367702, 11540.538378464767, 10678.412687302272, 11251.662450126509, 11262.324260544394, 11317.83023254652, 11331.660050198507, 7335.376492998155, 8005.759827205193, 8213.726872334797, 8240.258376746002, 8584.05575386707, 5947.851303717442, 6037.275526936795, 6045.848853778691, 6056.515478761777, 6158.630482171084, 9659.46872921996, 9966.750831229278, 10038.64864729731, 10088.495575221063, 10096.747581310527, 9738.805223895624, 9949.353292035994, 10173.847392288973, 10252.179825614083, 10253.692389228336, 7119.928800711927, 7586.317231449196, 7793.610319484116, 7797.142314345531, 7801.531908085533, 8496.872546911678, 8562.828743425222, 8582.871256931276, 8645.351598630003, 8657.437266577652, 6524.380183882524, 7183.52737688783, 7528.698852046076, 7658.425618078778, 7865.724699635485, 7484.32641062307, 7510.924890751023, 7513.8872916907385, 7578.545287282781, 7595.202503737028, 7201.279872012757, 7232.276772322725, 7238.6380680966795, 7341.74303899361, 7361.742339018108, 4916.631252655993, 4978.775955082103, 4994.725290109079, 5057.0138822929175, 5068.087744206078, 4982.825601104089, 5026.497350265091, 5043.9747801260755, 5133.486651334837, 5173.586113110867], "value": 4732.290694151483, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.75829819547965, 322.4518318857942, 342.86456849544413, 344.87756846319564, 346.7832604622111, 6738.52830301879, 6871.896921546181, 6884.139482564673, 6900.75847345343, 6972.965135174323, 6892.483063770224, 6921.480888933337, 6945.617991010492, 7150.678219480123, 7192.136943566779, 4500.054988452429, 4876.2685597160535, 5152.227165925123, 5164.2253661950635, 5174.379074511064, 5146.816232266581, 5159.097157997354, 5160.380754309469, 5193.246979188034, 5204.947950520503, 5087.720175390352, 5092.185250359943, 5103.438621751604, 5110.897782044357, 5119.897602047957, 4812.639052071108, 5023.824166154167, 5025.824096156617, 5088.211327244283, 5091.66904151229, 4228.112096459748, 4249.405083288342, 4255.55316691746, 4256.425382573344, 4286.292761694317, 5276.287701160371, 6610.975298828689, 6631.834204144887, 6680.966595166993, 6681.899771503431, 4213.325867861127, 4345.152695224432, 4523.095380923795, 5938.257717785277, 5968.940310596925, 7415.18432972378, 7429.739959101459, 7432.108147022392, 7457.888131678029, 7482.513636613658, 4587.564181402761, 4773.594244489223, 4785.832495862663, 4794.904101917942, 4796.856094317176, 7874.960625196894, 7879.212078792132, 7933.365330773582, 7945.523268603844, 7953.4432589718745, 4834.395700537433, 4843.6367272454, 4862.0, 4867.586255168279, 4891.877703057381, 4930.556249937451, 4944.505549445027, 4967.850964471072, 4971.130052240844, 4972.577330926912, 5941.643501389931, 5980.970095149583, 5982.461578457873, 5992.760289588367, 5998.340182579913, 7231.096112985877, 7525.623718814147, 7538.2838630331125, 7550.471466997257, 7599.4680372373405, 1446.4792674637122, 1691.9830801691826, 1693.6189357394735, 1704.2160606121074, 1715.5025042737466, 1006.4967516241879, 1057.9153667706564, 1072.9302595331278, 1073.8067147913293, 1099.9230053896151, 6946.8610627788175, 6981.1622605286675, 6990.685419156151, 6991.23096459389, 7015.719371225196, 7648.311651951351, 7669.5398276103615, 7674.654640541189, 7676.309132178131, 7682.577458239739, 7019.8596028079155, 7028.508004439743, 7037.19072306681, 7037.437005039585, 7098.964505177544, 3987.80060996949, 4054.108096218827, 4067.51189857219, 4100.200460910094, 4125.876223713293, 7980.640871160812, 7981.08217554977, 8000.399970002273, 8043.879341809878, 8083.555404452812, 7909.683612655429, 7915.287624113857, 7926.9603651982525, 7929.32600728933, 7974.322182614426, 8034.758957231293, 8038.075621303508, 8053.718119865894, 8056.315213206826, 8059.43583949118, 6826.941824017285, 7047.823804404726, 7731.453709258059, 7750.0699916010435, 7754.961225193838, 7478.551286922802, 7525.285097915689, 7530.021097257321, 7545.396368290633, 7585.16563178061, 8022.438429309892, 8022.638981245741, 8032.317253033558, 8033.678652854054, 8040.758777236692, 3981.92036159281, 4863.586595139312, 4873.805047798049, 4878.975605121952, 4888.36451261348, 7045.506814522934, 7521.962390188014, 7709.421793365632, 7779.0, 7871.370290376642, 6025.367336429612, 6788.389044985975, 7566.583837888969, 7592.8481430369975, 7625.885611715939, 7570.205128461433, 7581.658825352762, 7591.089069311718, 7604.391648667983, 7619.504732192389, 6045.75816967334, 7292.124945006633, 7380.372668323253, 7401.629918504161, 7432.6283685814415, 6693.9624358224555, 6968.3728464438445, 7523.924760752541, 7555.357794587521, 7570.280823321776, 7065.258147894397, 7238.782836514913, 7444.590547519721, 7475.289847464483, 7489.775306740807], "value": 5373.299514849384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.9930700692993, 714.9285071492851, 719.7121151539384, 744.4453881858014, 750.4634186556611, 15391.769123463144, 15457.536273911772, 15608.531744047697, 15611.375544978187, 15666.608334791636, 12182.939085304582, 16268.186590670479, 16297.83702162978, 16321.347146114142, 16368.590785230375, 769.7960040589248, 946.8485042393236, 952.4808979106404, 959.7744530035436, 962.210986990668, 944.4616568555925, 956.5026186383077, 965.6475386483918, 965.8647789309503, 974.1768205866032, 985.0051448037498, 1009.0615727373539, 1014.0265345268551, 1014.4319181258481, 1017.5726194998082, 978.7308490165261, 1001.689476262361, 1002.0080120680547, 1007.7833265847842, 1011.1405305490312, 730.5105579261907, 732.9047223860864, 735.0995031086876, 736.9005184300105, 742.7808796405074, 15490.380384784596, 15526.767098493532, 15557.844421555752, 16042.5989350266, 16076.196190190562, 12905.741885162244, 12945.093843430963, 13084.084114112016, 13097.083204175711, 13159.0, 10161.085502304828, 10378.532966016548, 10390.168786497137, 10409.323393979443, 10441.68674939753, 3463.1169051891607, 3515.8769443069627, 3528.558930133733, 3657.0, 3674.761140525884, 81500.59249703772, 81681.18318816795, 82119.9999999994, 82469.58765206195, 86878.56560717219, 9409.341346105844, 9502.857457138149, 9526.714198574055, 9833.26250531213, 10358.274920755626, 21248.575028499345, 21256.468588285108, 21924.780752192593, 21939.561208775736, 21955.451113721967, 7461.813454663677, 7520.059992500937, 7572.20491848348, 7612.733554325572, 7657.119431265364, 4155.10665206982, 4155.58444155582, 4202.600752928528, 4217.536071032246, 4282.935755963663, 3738.289724952305, 3770.5098337215986, 3782.867599634055, 3825.2158307547443, 3851.306764782366, 666.9233038200572, 682.331315310998, 688.834679676874, 694.2259380790483, 695.8726862482811, 504.2537045173164, 557.6208178438619, 607.2955371768727, 611.3641812514935, 643.9195100612424, 8303.252707256375, 8306.54314012735, 8365.665373385118, 8589.312854971588, 8686.348523860735, 563.495671374126, 579.8840231953626, 611.248164757351, 613.2702084519408, 616.7841255560518, 3909.980450097731, 3961.1285517186748, 3975.6024397560013, 4092.5293591237387, 4094.4975838686323, 65099.0, 68182.63634727278, 87350.0, 91596.16807663809, 93840.12319753566, 61760.0, 76558.61720691361, 79210.81183782133, 79615.60192199118, 82731.7590236147, 53934.92130157375, 68608.97086543706, 70822.0, 71103.93344099843, 71974.0, 7848.882266765889, 8038.87941680887, 8075.3135983439715, 8084.717034903751, 8228.136045715353, 41367.58632413638, 48409.75795121002, 50190.99236030664, 50545.73635659138, 51459.48540514697, 53548.92902142013, 64620.35379646144, 66339.66830165818, 69359.30640693528, 70095.0, 9356.48539330316, 9398.543225800013, 10111.443870587189, 10525.105366043972, 10945.179111566506, 11946.820797688215, 11986.880131198577, 12241.265524068229, 12242.204256723284, 12284.508619655113, 11326.37704926204, 11522.193446459003, 11634.301941883514, 11895.76208475843, 11918.642440726791, 11324.150688698215, 11412.201145920038, 11545.595904143314, 11767.941160294144, 11826.264261833176, 11210.943945280547, 11475.483603237708, 11539.961403473728, 11604.825927610924, 11812.645620631394, 9642.987486313836, 9723.387257839082, 9737.17234035115, 9771.218302535923, 9781.755456113655, 9548.02739712348, 9627.085426884434, 9714.376799466114, 9861.309708320348, 10046.24653151002], "value": 7012.52560855373, "unit": "score"}], "name": "dromaeo_css", "value": 7636.072759210641, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 143.0, 118.0, 118.0, 130.0, 115.0, 118.0, 115.0, 115.0], "value": 130.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 151.0, 177.0, 158.0, 132.0, 137.0, 122.0, 150.0, 156.0, 122.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 194.0, 190.0, 197.0, 197.0, 195.0, 203.0, 197.0, 202.0, 199.0], "value": 196.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 83.0, 137.0, 82.0, 78.0, 59.0, 83.0, 126.0, 56.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 127.0, 77.0, 78.0, 85.0, 111.0, 81.0, 78.0, 113.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 90.0, 78.0, 121.0, 128.0, 136.0, 85.0, 89.0, 85.0], "value": 103.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 94.0, 93.0, 94.0, 93.0, 95.0, 95.0, 98.0, 93.0, 93.0], "value": 99.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 89.0, 90.0, 90.0, 90.0, 90.0, 90.0, 114.0, 121.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 64.0, 65.0, 65.0, 66.0, 65.0, 80.0, 61.0, 59.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 71.0, 96.0, 109.0, 93.0, 70.0, 65.0, 61.0, 78.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 80.0, 82.0, 80.0, 79.0, 81.0, 81.0, 90.0, 87.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 125.0, 126.0, 128.0, 138.0, 151.0, 130.0, 150.0, 140.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 208.0, 222.0, 213.0, 168.0, 164.0, 167.0, 168.0, 166.0, 166.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 92.0, 97.0, 94.0, 97.0, 74.0, 68.0, 71.0, 70.0, 70.0], "value": 79.3, "unit": "score"}], "name": "kraken", "value": 1565.0, "alertThreshold": 2.0}]} 20:32:34 INFO - Return code: 0 20:32:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:32:34 ERROR - # TBPL SUCCESS # 20:32:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:32:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:32:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:32:34 INFO - 2016-07-18 20:32:34.917 screenresolution[1689:10383] starting screenresolution argv=screenresolution get 20:32:34 INFO - 2016-07-18 20:32:34.919 screenresolution[1689:10383] Display 0: 1600x1200x32@60 20:32:34 INFO - 2016-07-18 20:32:34.925 screenresolution[1690:10386] starting screenresolution argv=screenresolution list 20:32:34 INFO - Available Modes on Display 0 20:32:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:32:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:32:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:32:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:32:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:32:35 INFO - Intel Iris: 20:32:35 INFO - Chipset Model: Intel Iris 20:32:35 INFO - Type: GPU 20:32:35 INFO - Bus: Built-In 20:32:35 INFO - VRAM (Dynamic, Max): 1536 MB 20:32:35 INFO - Vendor: Intel (0x8086) 20:32:35 INFO - Device ID: 0x0a2e 20:32:35 INFO - Revision ID: 0x0009 20:32:35 INFO - Displays: 20:32:35 INFO - Display: 20:32:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:32:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:32:35 INFO - Display Serial Number: 1600x1200 60 20:32:35 INFO - Main Display: Yes 20:32:35 INFO - Mirror: Off 20:32:35 INFO - Online: Yes 20:32:35 INFO - Rotation: Supported 20:32:35 INFO - Return code: 0 20:32:35 INFO - Running post-action listener: _resource_record_post_action 20:32:35 INFO - Running post-run listener: _resource_record_post_run 20:32:36 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 37107200; Write bytes: 495540736; Read time: 242; Write time: 1577 20:32:36 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 189248000; Write bytes: 184786944; Read time: 17770; Write time: 412 20:32:36 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 35325440; Write bytes: 299956736; Read time: 227; Write time: 1127 20:32:36 INFO - Running post-run listener: _upload_blobber_files 20:32:36 INFO - Blob upload gear active. 20:32:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:32:36 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 20:32:36 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'] 20:32:36 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 20:32:36 INFO - (blobuploader) - INFO - Open directory for files ... 20:32:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:32:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:32:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:37 INFO - (blobuploader) - INFO - Done attempting. 20:32:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:32:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:32:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:38 INFO - (blobuploader) - INFO - Done attempting. 20:32:38 INFO - (blobuploader) - INFO - Iteration through files over. 20:32:39 INFO - Return code: 0 20:32:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:32:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:32:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42c3815033a58d75dcf580563f7d0730627e2aacc96abc6c8ff35e369b74bc1611f6064842c4766cee9b28732a29c659dd351ea1c4ee4ba92882875dd62845ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8290106859c0f87528640b4621c2065be5bc1e97630405c1bfcce8034bc59e70a3e3d1dd96d73c885fba246a7b7e43c088f96579e81b4c07c7eaf5fedf682b51"} 20:32:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:32:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:32:39 INFO - Contents: 20:32:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42c3815033a58d75dcf580563f7d0730627e2aacc96abc6c8ff35e369b74bc1611f6064842c4766cee9b28732a29c659dd351ea1c4ee4ba92882875dd62845ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8290106859c0f87528640b4621c2065be5bc1e97630405c1bfcce8034bc59e70a3e3d1dd96d73c885fba246a7b7e43c088f96579e81b4c07c7eaf5fedf682b51"} 20:32:39 INFO - Running post-run listener: copy_logs_to_upload_dir 20:32:39 INFO - Copying logs to upload dir... 20:32:39 INFO - mkdir: /builds/slave/test/build/upload/logs 20:32:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.233147 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-18 20:32:39.078107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:32:39.085481) ========= 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.cY5YOhIdRI/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.vhQSmYR695/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42c3815033a58d75dcf580563f7d0730627e2aacc96abc6c8ff35e369b74bc1611f6064842c4766cee9b28732a29c659dd351ea1c4ee4ba92882875dd62845ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8290106859c0f87528640b4621c2065be5bc1e97630405c1bfcce8034bc59e70a3e3d1dd96d73c885fba246a7b7e43c088f96579e81b4c07c7eaf5fedf682b51"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011020 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1468855738/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42c3815033a58d75dcf580563f7d0730627e2aacc96abc6c8ff35e369b74bc1611f6064842c4766cee9b28732a29c659dd351ea1c4ee4ba92882875dd62845ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8290106859c0f87528640b4621c2065be5bc1e97630405c1bfcce8034bc59e70a3e3d1dd96d73c885fba246a7b7e43c088f96579e81b4c07c7eaf5fedf682b51"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:32:39.117719) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:32:39.118028) ========= 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.cY5YOhIdRI/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.vhQSmYR695/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.005031 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:32:39.169838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:32:39.171337) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:32:39.171662) ========= ========= Total master_lag: 0.19 =========