builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0070 starttime: 1468465683.47 results: success (0) buildid: 20160708005359 builduid: 4495d366d0f74df0ab8635fef256276d revision: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:03.468582) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:03.469276) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:03.469742) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:03.497019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:03.497603) ========= 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.A3LWKBXwyv/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.52GInEPihf/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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-13 20:08:03-- 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% 8.02M=0.001s 2016-07-13 20:08:03 (8.02 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.475092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:03.995682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:03.996063) ========= 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.A3LWKBXwyv/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.52GInEPihf/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.020771 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:04.045063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 20:08:04.045464) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 60d09be974d615ae5c7fa1129516dbd0a6884dc5 --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 60d09be974d615ae5c7fa1129516dbd0a6884dc5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A3LWKBXwyv/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.52GInEPihf/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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-13 20:08:04,115 truncating revision to first 12 chars 2016-07-13 20:08:04,116 Setting DEBUG logging. 2016-07-13 20:08:04,116 attempt 1/10 2016-07-13 20:08:04,116 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/60d09be974d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 20:08:05,767 unpacking tar archive at: mozilla-beta-60d09be974d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.920505 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 20:08:05.989100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.989479) ========= script_repo_revision: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.990606) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:05.990993) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 20:08:06.016395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-13 20:08:06.016779) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A3LWKBXwyv/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.52GInEPihf/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:08:06 INFO - MultiFileLogger online at 20160713 20:08:06 in /builds/slave/test 20:08:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:08:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:08:06 INFO - {'append_to_log': False, 20:08:06 INFO - 'base_work_dir': '/builds/slave/test', 20:08:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:08:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:08:06 INFO - 'branch': 'Mozilla-Beta', 20:08:06 INFO - 'buildbot_json_path': 'buildprops.json', 20:08:06 INFO - 'config_files': ('talos/mac_config.py',), 20:08:06 INFO - 'default_actions': ('clobber', 20:08:06 INFO - 'read-buildbot-config', 20:08:06 INFO - 'download-and-extract', 20:08:06 INFO - 'populate-webroot', 20:08:06 INFO - 'create-virtualenv', 20:08:06 INFO - 'install', 20:08:06 INFO - 'run-tests'), 20:08:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:08:06 INFO - 'download_minidump_stackwalk': True, 20:08:06 INFO - 'download_symbols': 'ondemand', 20:08:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:08:06 INFO - 'tooltool.py': '/tools/tooltool.py', 20:08:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:08:06 INFO - '/tools/misc-python/virtualenv.py')}, 20:08:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:08:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:08:06 INFO - 'installer_path': 'installer.exe', 20:08:06 INFO - 'log_level': 'info', 20:08:06 INFO - 'log_name': 'talos', 20:08:06 INFO - 'log_to_console': True, 20:08:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:08:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:08:06 INFO - 'opt_config_files': (), 20:08:06 INFO - 'pip_index': False, 20:08:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:08:06 INFO - 'cmd': ('bash', 20:08:06 INFO - '-c', 20:08:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:08:06 INFO - 'enabled': True, 20:08:06 INFO - 'halt_on_failure': False, 20:08:06 INFO - 'name': 'check_screen_resolution'},), 20:08:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:08:06 INFO - 'cmd': ('bash', 20:08:06 INFO - '-c', 20:08:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:08:06 INFO - 'enabled': True, 20:08:06 INFO - 'halt_on_failure': False, 20:08:06 INFO - 'name': 'check_screen_resolution'},), 20:08:06 INFO - 'run_cmd_checks_enabled': True, 20:08:06 INFO - 'sps_profile': False, 20:08:06 INFO - 'sps_profile_interval': 0, 20:08:06 INFO - 'suite': 'dromaeojs', 20:08:06 INFO - 'system_bits': '32', 20:08:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:08:06 INFO - 'title': 't-yosemite-r7-0070', 20:08:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:08:06 INFO - 'use_talos_json': True, 20:08:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:08:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:08:06 INFO - 'work_dir': 'build'} 20:08:06 INFO - ##### 20:08:06 INFO - ##### Running clobber step. 20:08:06 INFO - ##### 20:08:06 INFO - Running pre-action listener: _resource_record_pre_action 20:08:06 INFO - Running main action method: clobber 20:08:06 INFO - rmtree: /builds/slave/test/build 20:08:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:08:07 INFO - Running post-action listener: _resource_record_post_action 20:08:07 INFO - ##### 20:08:07 INFO - ##### Running read-buildbot-config step. 20:08:07 INFO - ##### 20:08:07 INFO - Running pre-action listener: _resource_record_pre_action 20:08:07 INFO - Running main action method: read_buildbot_config 20:08:07 INFO - Using buildbot properties: 20:08:07 INFO - { 20:08:07 INFO - "project": "", 20:08:07 INFO - "product": "firefox", 20:08:07 INFO - "script_repo_revision": "production", 20:08:07 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 20:08:07 INFO - "repository": "", 20:08:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 20:08:07 INFO - "buildid": "20160708005359", 20:08:07 INFO - "pgo_build": "False", 20:08:07 INFO - "basedir": "/builds/slave/test", 20:08:07 INFO - "buildnumber": 31, 20:08:07 INFO - "slavename": "t-yosemite-r7-0070", 20:08:07 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 20:08:07 INFO - "platform": "yosemite_r7", 20:08:07 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:08:07 INFO - "branch": "mozilla-beta", 20:08:07 INFO - "repo_path": "releases/mozilla-beta", 20:08:07 INFO - "revision": "60d09be974d615ae5c7fa1129516dbd0a6884dc5", 20:08:07 INFO - "stage_platform": "macosx64", 20:08:07 INFO - "builduid": "4495d366d0f74df0ab8635fef256276d", 20:08:07 INFO - "slavebuilddir": "test" 20:08:07 INFO - } 20:08:07 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg. 20:08:07 INFO - Running post-action listener: _resource_record_post_action 20:08:07 INFO - ##### 20:08:07 INFO - ##### Running download-and-extract step. 20:08:07 INFO - ##### 20:08:07 INFO - Running pre-action listener: _resource_record_pre_action 20:08:07 INFO - Running main action method: download_and_extract 20:08:07 INFO - mkdir: /builds/slave/test/build/tests 20:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:07 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.test_packages.json 20:08:07 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/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:08:08 INFO - Downloaded 1165 bytes. 20:08:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:08:08 INFO - Using the following test package requirements: 20:08:08 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:08:08 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:08 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 20:08:08 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:08 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 20:08:08 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:08:08 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:08 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 20:08:08 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:08:08 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:08 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 20:08:08 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:08 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 20:08:08 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:08 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 20:08:08 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:08:08 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 20:08:08 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 20:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.common.tests.zip 20:08:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 20:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/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:08:11 INFO - Downloaded 18351484 bytes. 20:08:11 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:08:11 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:08:14 INFO - Return code: 0 20:08:14 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:08: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:08:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.common.tests.zip 20:08:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 20:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/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:08:14 INFO - Downloaded 18351484 bytes. 20:08:14 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:08:14 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:08:18 INFO - Return code: 0 20:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.talos.tests.zip 20:08:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 20:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/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:08:21 INFO - Downloaded 10840145 bytes. 20:08:21 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:08:21 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:08:21 INFO - Return code: 0 20:08:21 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:08:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg 20:08:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 20:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 20:08:36 INFO - Downloaded 86183525 bytes. 20:08:36 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg 20:08:36 INFO - mkdir: /builds/slave/test/properties 20:08:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:08:36 INFO - Writing to file /builds/slave/test/properties/build_url 20:08:36 INFO - Contents: 20:08:36 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg 20:08:36 INFO - Running post-action listener: _resource_record_post_action 20:08:36 INFO - Running post-action listener: set_extra_try_arguments 20:08:36 INFO - ##### 20:08:36 INFO - ##### Running populate-webroot step. 20:08:36 INFO - ##### 20:08:36 INFO - Running pre-action listener: _resource_record_pre_action 20:08:36 INFO - Running main action method: populate_webroot 20:08:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:36 INFO - '--tppagecycles', 20:08:36 INFO - '7'], 20:08:36 INFO - 'tests': ['tsvgm']}}, 20:08:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:08:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:08:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:08:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['damp', 'tps']}, 20:08:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'tests': ['damp', 'tps']}, 20:08:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['dromaeo_dom']}, 20:08:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'other-e10s': {'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['a11yr', 20:08:36 INFO - 'ts_paint', 20:08:36 INFO - 'tpaint', 20:08:36 INFO - 'sessionrestore', 20:08:36 INFO - 'sessionrestore_no_auto_restore', 20:08:36 INFO - 'tabpaint']}, 20:08:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['tsvgx', 20:08:36 INFO - 'tsvgr_opacity', 20:08:36 INFO - 'tart', 20:08:36 INFO - 'tscrollx', 20:08:36 INFO - 'cart']}, 20:08:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:08:36 INFO - 'tsvgr_opacity', 20:08:36 INFO - 'tart', 20:08:36 INFO - 'tscrollx', 20:08:36 INFO - 'cart']}, 20:08:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'talos_options': ['--disable-e10s'], 20:08:36 INFO - 'tests': ['tp5o']}, 20:08:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'tests': ['tp5o']}, 20:08:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'talos_options': ['--disable-e10s', 20:08:36 INFO - '--xperf_path', 20:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:36 INFO - 'tests': ['tp5n']}, 20:08:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:36 INFO - 'talos_options': ['--xperf_path', 20:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:36 INFO - 'tests': ['tp5n']}}, 20:08:36 INFO - 'talos.zip': {'path': '', 20:08:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:36 INFO - Running post-action listener: _resource_record_post_action 20:08:36 INFO - ##### 20:08:36 INFO - ##### Running create-virtualenv step. 20:08:36 INFO - ##### 20:08:36 INFO - Running pre-action listener: _resource_record_pre_action 20:08:36 INFO - Running main action method: create_virtualenv 20:08:36 INFO - Creating virtualenv /builds/slave/test/build/venv 20:08:36 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:08:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:08:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:37 INFO - Using real prefix '/tools/python27' 20:08:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:08:37 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:40 INFO - Installing pip.................done. 20:08:40 INFO - Return code: 0 20:08:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:08:40 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:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:40 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:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:40 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 0x10b88ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b89c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8615d3a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b72be00>, '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 0x10b594db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b726b20>, '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.A3LWKBXwyv/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.52GInEPihf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:08:40 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:08:40 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:08:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A3LWKBXwyv/Render', 20:08:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:40 INFO - 'HOME': '/Users/cltbld', 20:08:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:40 INFO - 'LOGNAME': 'cltbld', 20:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:40 INFO - 'MOZ_NO_REMOTE': '1', 20:08:40 INFO - 'NO_EM_RESTART': '1', 20:08:40 INFO - 'PAGER': '/bin/cat', 20:08:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:40 INFO - 'PWD': '/builds/slave/test', 20:08:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:40 INFO - 'SHELL': '/bin/bash', 20:08:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.52GInEPihf/Listeners', 20:08:40 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 20:08:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:40 INFO - 'USER': 'cltbld', 20:08:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:40 INFO - 'XPC_FLAGS': '0x0', 20:08:40 INFO - 'XPC_SERVICE_NAME': '0', 20:08:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:40 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:08:40 INFO - Cleaning up... 20:08:40 INFO - Return code: 0 20:08:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:08:40 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:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:40 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:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:40 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 0x10b88ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b89c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8615d3a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b72be00>, '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 0x10b594db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b726b20>, '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.A3LWKBXwyv/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.52GInEPihf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:08:40 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:08:40 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:08:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A3LWKBXwyv/Render', 20:08:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:40 INFO - 'HOME': '/Users/cltbld', 20:08:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:40 INFO - 'LOGNAME': 'cltbld', 20:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:40 INFO - 'MOZ_NO_REMOTE': '1', 20:08:40 INFO - 'NO_EM_RESTART': '1', 20:08:40 INFO - 'PAGER': '/bin/cat', 20:08:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:40 INFO - 'PWD': '/builds/slave/test', 20:08:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:40 INFO - 'SHELL': '/bin/bash', 20:08:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.52GInEPihf/Listeners', 20:08:40 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 20:08:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:40 INFO - 'USER': 'cltbld', 20:08:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:40 INFO - 'XPC_FLAGS': '0x0', 20:08:40 INFO - 'XPC_SERVICE_NAME': '0', 20:08:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:41 INFO - Downloading/unpacking psutil>=0.7.1 20:08:41 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:08:41 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:08:41 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:08:41 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:08:41 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:08:41 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:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:43 INFO - Installing collected packages: psutil 20:08:43 INFO - Running setup.py install for psutil 20:08:43 INFO - building 'psutil._psutil_osx' extension 20:08:43 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:08:44 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:08:44 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:08:44 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:08:44 INFO - building 'psutil._psutil_posix' extension 20:08:44 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:08:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:08:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:08:44 INFO - ^ 20:08:44 INFO - 1 warning generated. 20:08:44 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:08:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:44 INFO - Successfully installed psutil 20:08:44 INFO - Cleaning up... 20:08:44 INFO - Return code: 0 20:08:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b88ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b89c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8615d3a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b72be00>, '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 0x10b594db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b726b20>, '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.A3LWKBXwyv/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.52GInEPihf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A3LWKBXwyv/Render', 20:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:44 INFO - 'HOME': '/Users/cltbld', 20:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:44 INFO - 'LOGNAME': 'cltbld', 20:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:44 INFO - 'MOZ_NO_REMOTE': '1', 20:08:44 INFO - 'NO_EM_RESTART': '1', 20:08:44 INFO - 'PAGER': '/bin/cat', 20:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:44 INFO - 'PWD': '/builds/slave/test', 20:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:44 INFO - 'SHELL': '/bin/bash', 20:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.52GInEPihf/Listeners', 20:08:44 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 20:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:44 INFO - 'USER': 'cltbld', 20:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:44 INFO - 'XPC_FLAGS': '0x0', 20:08:44 INFO - 'XPC_SERVICE_NAME': '0', 20:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:08:47 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:08:47 INFO - Installing collected packages: mozsystemmonitor 20:08:47 INFO - Running setup.py install for mozsystemmonitor 20:08:47 INFO - Successfully installed mozsystemmonitor 20:08:47 INFO - Cleaning up... 20:08:47 INFO - Return code: 0 20:08:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b88ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b89c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8615d3a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b72be00>, '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 0x10b594db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b726b20>, '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.A3LWKBXwyv/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.52GInEPihf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:08:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A3LWKBXwyv/Render', 20:08:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:47 INFO - 'HOME': '/Users/cltbld', 20:08:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:47 INFO - 'LOGNAME': 'cltbld', 20:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:47 INFO - 'MOZ_NO_REMOTE': '1', 20:08:47 INFO - 'NO_EM_RESTART': '1', 20:08:47 INFO - 'PAGER': '/bin/cat', 20:08:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:47 INFO - 'PWD': '/builds/slave/test', 20:08:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:47 INFO - 'SHELL': '/bin/bash', 20:08:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.52GInEPihf/Listeners', 20:08:47 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 20:08:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:47 INFO - 'USER': 'cltbld', 20:08:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:47 INFO - 'XPC_FLAGS': '0x0', 20:08:47 INFO - 'XPC_SERVICE_NAME': '0', 20:08:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:47 INFO - Downloading/unpacking blobuploader==1.2.4 20:08:47 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:08:47 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:08:47 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:08:47 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:08:47 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:08:47 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:08:50 INFO - Downloading blobuploader-1.2.4.tar.gz 20:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:08:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:08:50 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:08:50 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:08:50 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:08:50 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:08:50 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:08:50 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:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:08:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:51 INFO - Downloading docopt-0.6.1.tar.gz 20:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:08:51 INFO - Installing collected packages: blobuploader, requests, docopt 20:08:51 INFO - Running setup.py install for blobuploader 20:08:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:08:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:08:51 INFO - Running setup.py install for requests 20:08:52 INFO - Running setup.py install for docopt 20:08:52 INFO - Successfully installed blobuploader requests docopt 20:08:52 INFO - Cleaning up... 20:08:52 INFO - Return code: 0 20:08:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:52 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 0x10b88ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b89c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8615d3a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b72be00>, '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 0x10b594db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b726b20>, '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.A3LWKBXwyv/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.52GInEPihf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:08:52 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:08:52 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:08:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A3LWKBXwyv/Render', 20:08:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:52 INFO - 'HOME': '/Users/cltbld', 20:08:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:52 INFO - 'LOGNAME': 'cltbld', 20:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:52 INFO - 'MOZ_NO_REMOTE': '1', 20:08:52 INFO - 'NO_EM_RESTART': '1', 20:08:52 INFO - 'PAGER': '/bin/cat', 20:08:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:52 INFO - 'PWD': '/builds/slave/test', 20:08:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:52 INFO - 'SHELL': '/bin/bash', 20:08:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.52GInEPihf/Listeners', 20:08:52 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 20:08:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:52 INFO - 'USER': 'cltbld', 20:08:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:52 INFO - 'XPC_FLAGS': '0x0', 20:08:52 INFO - 'XPC_SERVICE_NAME': '0', 20:08:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:52 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-4BmEsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:52 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-MbHnRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:53 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-t9DG9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:53 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-dwt008-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:53 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-m0eiv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:53 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-M5wiTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:53 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-U6pFeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:53 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-vyPLXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:53 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-0WPQqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:53 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-fqmDc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:53 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-4gSDx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:53 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-OyHTYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:54 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-k0WgHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:54 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-mzvD3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:54 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-DDh6LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:54 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-qiv2iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:54 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-SeJIp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:08:54 INFO - Running setup.py install for manifestparser 20:08:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:08:54 INFO - Running setup.py install for mozcrash 20:08:54 INFO - Running setup.py install for mozdebug 20:08:55 INFO - Running setup.py install for mozdevice 20:08:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:08:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:08:55 INFO - Running setup.py install for mozfile 20:08:55 INFO - Running setup.py install for mozhttpd 20:08:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:08:55 INFO - Running setup.py install for mozinfo 20:08:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:08:55 INFO - Running setup.py install for mozInstall 20:08:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:08:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:08:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:08:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:08:55 INFO - Running setup.py install for mozleak 20:08:55 INFO - Running setup.py install for mozlog 20:08:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:08:56 INFO - Running setup.py install for moznetwork 20:08:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:08:56 INFO - Running setup.py install for mozprocess 20:08:56 INFO - Running setup.py install for mozprofile 20:08:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:08:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:08:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:08:56 INFO - Running setup.py install for mozrunner 20:08:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:08:56 INFO - Running setup.py install for mozscreenshot 20:08:56 INFO - Running setup.py install for moztest 20:08:57 INFO - Running setup.py install for mozversion 20:08:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:08:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:08:57 INFO - Cleaning up... 20:08:57 INFO - Return code: 0 20:08:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08: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:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:57 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 0x10b88ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b89c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8615d3a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b72be00>, '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 0x10b594db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b726b20>, '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.A3LWKBXwyv/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.52GInEPihf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:08:57 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:08:57 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:08:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A3LWKBXwyv/Render', 20:08:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:57 INFO - 'HOME': '/Users/cltbld', 20:08:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:57 INFO - 'LOGNAME': 'cltbld', 20:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:57 INFO - 'MOZ_NO_REMOTE': '1', 20:08:57 INFO - 'NO_EM_RESTART': '1', 20:08:57 INFO - 'PAGER': '/bin/cat', 20:08:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:57 INFO - 'PWD': '/builds/slave/test', 20:08:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:57 INFO - 'SHELL': '/bin/bash', 20:08:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.52GInEPihf/Listeners', 20:08:57 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 20:08:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:57 INFO - 'USER': 'cltbld', 20:08:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:57 INFO - 'XPC_FLAGS': '0x0', 20:08:57 INFO - 'XPC_SERVICE_NAME': '0', 20:08:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Q4sWoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:57 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:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-E5ztXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:57 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:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-r7_12b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:57 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:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-2Bho8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:57 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:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-5Hpnxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:57 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:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-KqLnIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:58 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:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-y_CXaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:58 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:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-cwcjDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:58 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:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-pui_tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:58 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:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-gjlPMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:58 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:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-kIrEVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:58 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:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-kh8bz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:58 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:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-8PoC5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:58 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:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-YQW6Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:58 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:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-haH2LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:59 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:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:59 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-e6mbVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:59 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:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:59 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Y06RIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:09:01 INFO - Downloading blessings-1.6.tar.gz 20:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:01 INFO - Installing collected packages: blessings 20:09:01 INFO - Running setup.py install for blessings 20:09:01 INFO - Successfully installed blessings 20:09:01 INFO - Cleaning up... 20:09:02 INFO - Return code: 0 20:09:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:02 INFO - Reading from file tmpfile_stdout 20:09:02 INFO - Current package versions: 20:09:02 INFO - blessings == 1.6 20:09:02 INFO - blobuploader == 1.2.4 20:09:02 INFO - docopt == 0.6.1 20:09:02 INFO - manifestparser == 1.1 20:09:02 INFO - mozInstall == 1.12 20:09:02 INFO - mozcrash == 0.17 20:09:02 INFO - mozdebug == 0.1 20:09:02 INFO - mozdevice == 0.48 20:09:02 INFO - mozfile == 1.2 20:09:02 INFO - mozhttpd == 0.7 20:09:02 INFO - mozinfo == 0.9 20:09:02 INFO - mozleak == 0.1 20:09:02 INFO - mozlog == 3.1 20:09:02 INFO - moznetwork == 0.27 20:09:02 INFO - mozprocess == 0.22 20:09:02 INFO - mozprofile == 0.28 20:09:02 INFO - mozrunner == 6.11 20:09:02 INFO - mozscreenshot == 0.1 20:09:02 INFO - mozsystemmonitor == 0.0 20:09:02 INFO - moztest == 0.7 20:09:02 INFO - mozversion == 1.4 20:09:02 INFO - psutil == 3.1.1 20:09:02 INFO - requests == 1.2.3 20:09:02 INFO - wsgiref == 0.1.2 20:09:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:02 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 0x10b88ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b89c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8615d3a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b72be00>, '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 0x10b594db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b726b20>, '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.A3LWKBXwyv/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.52GInEPihf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:09:02 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:09:02 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:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A3LWKBXwyv/Render', 20:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:02 INFO - 'HOME': '/Users/cltbld', 20:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:02 INFO - 'LOGNAME': 'cltbld', 20:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:02 INFO - 'MOZ_NO_REMOTE': '1', 20:09:02 INFO - 'NO_EM_RESTART': '1', 20:09:02 INFO - 'PAGER': '/bin/cat', 20:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:02 INFO - 'PWD': '/builds/slave/test', 20:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:02 INFO - 'SHELL': '/bin/bash', 20:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.52GInEPihf/Listeners', 20:09:02 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 20:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:02 INFO - 'USER': 'cltbld', 20:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:02 INFO - 'XPC_FLAGS': '0x0', 20:09:02 INFO - 'XPC_SERVICE_NAME': '0', 20:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:02 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:09:02 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:09:02 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:09:02 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:09:02 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:09:02 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:09:02 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:09:02 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:09:02 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:09:02 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:09:02 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:09:02 INFO - Cleaning up... 20:09:02 INFO - Return code: 0 20:09:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:02 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 0x10b88ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b89c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8615d3a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b72be00>, '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 0x10b594db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b726b20>, '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.A3LWKBXwyv/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.52GInEPihf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:09:02 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:09:02 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:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A3LWKBXwyv/Render', 20:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:02 INFO - 'HOME': '/Users/cltbld', 20:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:02 INFO - 'LOGNAME': 'cltbld', 20:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:02 INFO - 'MOZ_NO_REMOTE': '1', 20:09:02 INFO - 'NO_EM_RESTART': '1', 20:09:02 INFO - 'PAGER': '/bin/cat', 20:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:02 INFO - 'PWD': '/builds/slave/test', 20:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:02 INFO - 'SHELL': '/bin/bash', 20:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.52GInEPihf/Listeners', 20:09:02 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 20:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:02 INFO - 'USER': 'cltbld', 20:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:02 INFO - 'XPC_FLAGS': '0x0', 20:09:02 INFO - 'XPC_SERVICE_NAME': '0', 20:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:02 INFO - Downloading/unpacking jsonschema 20:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:05 INFO - Downloading/unpacking functools32 (from jsonschema) 20:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:05 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:05 INFO - warning: no files found matching '*.txt' 20:09:05 INFO - no previously-included directories found matching 'build' 20:09:05 INFO - no previously-included directories found matching 'dist' 20:09:05 INFO - no previously-included directories found matching '.git*' 20:09:05 INFO - Installing collected packages: jsonschema, functools32 20:09:05 INFO - Running setup.py install for functools32 20:09:05 INFO - warning: no files found matching '*.txt' 20:09:05 INFO - no previously-included directories found matching 'build' 20:09:05 INFO - no previously-included directories found matching 'dist' 20:09:05 INFO - no previously-included directories found matching '.git*' 20:09:05 INFO - Successfully installed jsonschema functools32 20:09:05 INFO - Cleaning up... 20:09:06 INFO - Return code: 0 20:09:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:06 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 0x10b88ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b89c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8615d3a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b72be00>, '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 0x10b594db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b726b20>, '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.A3LWKBXwyv/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.52GInEPihf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:09:06 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:09:06 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:09:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A3LWKBXwyv/Render', 20:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:06 INFO - 'HOME': '/Users/cltbld', 20:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:06 INFO - 'LOGNAME': 'cltbld', 20:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:06 INFO - 'MOZ_NO_REMOTE': '1', 20:09:06 INFO - 'NO_EM_RESTART': '1', 20:09:06 INFO - 'PAGER': '/bin/cat', 20:09:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:06 INFO - 'PWD': '/builds/slave/test', 20:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:06 INFO - 'SHELL': '/bin/bash', 20:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.52GInEPihf/Listeners', 20:09:06 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 20:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:06 INFO - 'USER': 'cltbld', 20:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:06 INFO - 'XPC_FLAGS': '0x0', 20:09:06 INFO - 'XPC_SERVICE_NAME': '0', 20:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:06 INFO - Downloading/unpacking flake8 20:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:09:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:09:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:09:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:10 INFO - no previously-included directories found matching 'docs/_build' 20:09:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:09:10 INFO - Running setup.py install for pep8 20:09:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:10 INFO - no previously-included directories found matching 'docs/_build' 20:09:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:09:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:09:10 INFO - Cleaning up... 20:09:10 INFO - Return code: 0 20:09:10 INFO - Running post-action listener: _resource_record_post_action 20:09:10 INFO - Running post-action listener: _start_resource_monitoring 20:09:10 INFO - Starting resource monitoring. 20:09:10 INFO - ##### 20:09:10 INFO - ##### Running install step. 20:09:10 INFO - ##### 20:09:10 INFO - Running pre-action listener: _resource_record_pre_action 20:09:10 INFO - Running main action method: install 20:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:10 INFO - Reading from file tmpfile_stdout 20:09:10 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:10 INFO - Reading from file tmpfile_stdout 20:09:10 INFO - Output received: 20:09:10 INFO - Usage: mozinstall [options] installer 20:09:10 INFO - Options: 20:09:10 INFO - -h, --help show this help message and exit 20:09:10 INFO - -d DEST, --destination=DEST 20:09:10 INFO - Directory to install application into. [default: 20:09:10 INFO - "/builds/slave/test"] 20:09:10 INFO - --app=APP Application being installed. [default: firefox] 20:09:10 INFO - mkdir: /builds/slave/test/build/application 20:09:10 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:09:10 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:09:32 INFO - Reading from file tmpfile_stdout 20:09:32 INFO - Output received: 20:09:32 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:09:32 INFO - Running post-action listener: _resource_record_post_action 20:09:32 INFO - ##### 20:09:32 INFO - ##### Running run-tests step. 20:09:32 INFO - ##### 20:09:32 INFO - Running pre-action listener: _resource_record_pre_action 20:09:32 INFO - Running main action method: run_tests 20:09:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:09:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:09:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:09:32 INFO - 2016-07-13 20:09:32.993 screenresolution[1935:12317] starting screenresolution argv=screenresolution get 20:09:32 INFO - 2016-07-13 20:09:32.996 screenresolution[1935:12317] Display 0: 1600x1200x32@60 20:09:33 INFO - 2016-07-13 20:09:33.001 screenresolution[1936:12320] starting screenresolution argv=screenresolution list 20:09:33 INFO - Available Modes on Display 0 20:09:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:09:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:09:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:09:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:09:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:09:33 INFO - Intel Iris: 20:09:33 INFO - Chipset Model: Intel Iris 20:09:33 INFO - Type: GPU 20:09:33 INFO - Bus: Built-In 20:09:33 INFO - VRAM (Dynamic, Max): 1536 MB 20:09:33 INFO - Vendor: Intel (0x8086) 20:09:33 INFO - Device ID: 0x0a2e 20:09:33 INFO - Revision ID: 0x0009 20:09:33 INFO - Displays: 20:09:33 INFO - Display: 20:09:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:09:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:09:33 INFO - Display Serial Number: 1600x1200 60 20:09:33 INFO - Main Display: Yes 20:09:33 INFO - Mirror: Off 20:09:33 INFO - Online: Yes 20:09:33 INFO - Rotation: Supported 20:09:33 INFO - Return code: 0 20:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:33 INFO - Python 2.7.3 20:09:33 INFO - Return code: 0 20:09:33 INFO - grabbing minidump binary from tooltool 20:09:33 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:09:33 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 0x10b72be00>, '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 0x10b594db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b726b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:33 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:09:33 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:09:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:33 INFO - Return code: 0 20:09:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:09:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:09:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:09:34 INFO - Return code: 0 20:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:09:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A3LWKBXwyv/Render', 20:09:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:34 INFO - 'HOME': '/Users/cltbld', 20:09:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:34 INFO - 'LOGNAME': 'cltbld', 20:09:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:34 INFO - 'MOZ_NO_REMOTE': '1', 20:09:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:34 INFO - 'NO_EM_RESTART': '1', 20:09:34 INFO - 'PAGER': '/bin/cat', 20:09:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:34 INFO - 'PWD': '/builds/slave/test', 20:09:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:34 INFO - 'SHELL': '/bin/bash', 20:09:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.52GInEPihf/Listeners', 20:09:34 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 20:09:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:34 INFO - 'USER': 'cltbld', 20:09:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:34 INFO - 'XPC_FLAGS': '0x0', 20:09:34 INFO - 'XPC_SERVICE_NAME': '0', 20:09:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:09:34 INFO - mozversion application_buildid: 20160708005359 20:09:34 INFO - mozversion application_changeset: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 20:09:34 INFO - mozversion application_display_name: Firefox 20:09:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:34 INFO - mozversion application_name: Firefox 20:09:34 INFO - mozversion application_remotingname: firefox 20:09:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:09:34 INFO - mozversion application_vendor: Mozilla 20:09:34 INFO - mozversion application_version: 48.0 20:09:34 INFO - mozversion platform_buildid: 20160708005359 20:09:34 INFO - mozversion platform_changeset: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 20:09:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:09:34 INFO - mozversion platform_version: 48.0 20:09:34 INFO - using testdate: 1468465774 20:09:34 INFO - actual date: 1468465774 20:09:34 INFO - starting webserver on 'localhost:50331' 20:09:34 INFO - SUITE-START | Running 2 tests 20:09:34 INFO - TEST-START | dromaeo_css 20:09:34 INFO - operating with platform_type : mac_ 20:09:34 INFO - Initialising browser for dromaeo_css test... 20:09:34 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmp22o2KN/profile http://localhost:50331/getInfo.html) 20:09:36 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 20:09:36 INFO - PROCESS | 1954 | colorDepth:24 20:09:36 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 20:09:36 INFO - PROCESS | 1954 | __metrics 20:09:36 INFO - PROCESS | 1954 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:09:36 ERROR - PROCESS | 1954 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:09:37 INFO - TEST-INFO | 1954: exit 0 20:09:37 INFO - Browser initialized. 20:09:37 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:37 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmp22o2KN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:49 INFO - PROCESS | 1957 | RSS: Main: 161767424 20:09:49 INFO - PROCESS | 1957 | 20:10:40 INFO - PROCESS | 1957 | 1468465840518 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:12:50 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50331/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50331/tests/dromaeo/cssquery-ext.html) 20:12:52 INFO - PROCESS | 1957 | RSS: Main: 300216320 20:12:52 INFO - PROCESS | 1957 | 20:15:55 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50331/tests/dromaeo/cssquery-ext.html (next: http://localhost:50331/tests/dromaeo/cssquery-jquery.html) 20:15:55 INFO - PROCESS | 1957 | RSS: Main: 301301760 20:15:55 INFO - PROCESS | 1957 | 20:18:57 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50331/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50331/tests/dromaeo/cssquery-mootools.html) 20:18:58 INFO - PROCESS | 1957 | RSS: Main: 307961856 20:18:58 INFO - PROCESS | 1957 | 20:22:00 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50331/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50331/tests/dromaeo/cssquery-prototype.html) 20:22:00 INFO - PROCESS | 1957 | RSS: Main: 308916224 20:22:00 INFO - PROCESS | 1957 | 20:25:04 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50331/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50331/tests/dromaeo/cssquery-yui.html) 20:25:04 INFO - PROCESS | 1957 | RSS: Main: 271765504 20:25:04 INFO - PROCESS | 1957 | 20:28:07 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50331/tests/dromaeo/cssquery-yui.html (next: http://localhost:50331/tests/dromaeo/cssquery-dojo.html) 20:28:07 INFO - PROCESS | 1957 | RSS: Main: 314503168 20:28:07 INFO - PROCESS | 1957 | 20:28:07 INFO - PROCESS | 1957 | __start_tp_report 20:28:07 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 20:28:07 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 20:28:07 INFO - PROCESS | 1957 | |i|pagename|runs| 20:28:07 INFO - PROCESS | 1957 | |0;dojo.html;3008.969910300897;3601.4237721964473;3612.241429299847;3629.4555816627512;3695.390260607;5954.4640982311585;5974.253218347707;5974.372690867456;5976.611520251186;6014.127951447038;5943.019401798698;5999.640021598696;5999.940000600003;6000.909986350197;6029.547783916213;5214.400343960437;5262.973685131578;5352.437994010631;5359.5712343012465;5405.729713514309;5329.946700533003;5359.1425371940495;5379.977804217206;5381.946180538183;5391.838244852661;5305.4164041955355;5345.3585569731495;5354.22363757255;5390.8921821563545;5397.676139431627;5393.487618676219;5393.4876186762585;5413.162195559475;5421.403645598981;5445.074337362658;5146.6911985281;5215.530602245778;5309.548688361494;5313.867153321159;5346.064438723247;5764.221830052931;5772.278465191851;5811.186433899257;5840.182374467578;5848.736806843703;6247.187865577446;6291.905621415683;6304.621722696607;6307.148534947815;6317.084022816712;6139.3388173831445;6230.937690623081;6283;6361.459275961549;6365.554411191219;6019.969900150515;6045.586721693188;6063.6664983426335;6078.209832721718;6084.878302433926;6526.2494813096155;6535.705893234815;6538.1500404947055;6546.149000629887;6555.737770489222;5826.563007774434;6142.529470848956;6143.262808463013;6211.3478084801345;6245.219347581552;6325.272593651697;6342.968285158637;6343.397377249154;6344.49244060474;6347.5239357047485;6166.537509686791;6214.875702486015;6216.067589861557;6217.222847144107;6238.875222495615;6110.285381942539;6148.1085242639565;6236.469900058546;6238.844028899314;6268.49852011838;5000.924986125211;5041.294218809369;5048.268001139814;5057.317262169634;5062.746862656926;4524.932126018112;4579.22153233951;4594.47163576193;4602.907941841145;4610.239310513794;6034.08842306233;6103.755849766048;6109.083637454329;6110.376504976068;6135.754569817157;6237.09562113491;6238.656873871981;6245.656488893063;6247.468965137923;6290.182276304051;6130.141780150782;6152.446279834837;6167.814965551041;6180.81457556274;6188.4739797116845;5531.778728850882;5567.610267281251;5567.860803479864;5589.944100559023;5621.662700237999;6414.61512309263;6495.772647957298;6540.50946179048;6564.507661925375;6598.307177746459;6308.179936608211;6328.810135695937;6333.493320534439;6342.302346741947;6353.237611486651;6579.407853293226;6579.703913323816;6599.373059559334;6605.372489613479;6622.403983641495;6151.84620384494;6162.506999440124;6214.968925155526;6265.373462653698;6265.530085243716;6254.030625253093;6301.527385446201;6303.936960630518;6305.180326557518;6332.905006425;6144.1567529740005;6245.68771561411;6248.812535623939;6292.119103325446;6319.842003949938;6158.261008678808;6241.719122639402;6255.655938923403;6267.2792628848265;6277.843053923689;6174.567780255518;6179.536534759821;6207.379262073757;6213.9067913982235;6220.906686399617;5095.388553373619;6148.415900489446;6219.0982307566055;6273.905891411724;6300.054991751274;6076.848078798065;6132.226125838312;6152.477039451696;6179.073139029181;6237.594556353823 20:28:07 INFO - PROCESS | 1957 | |1;ext.html;521.9743204602955;545.435474284116;590.9540113998223;596.052276879761;610.5451438678185;26082.739172608268;38584.614153858456;39562.99999999996;39583.80208098955;39626;42142.15715685692;42683.14633707324;42716.57283427165;42819;42940.785296073474;8989.910100898973;9544.713658590235;9737.464439455827;9765.804683906317;9776.902230977706;11567.537298508092;11822.527098916033;11846.644600661994;11848.881511184907;11863.7627247455;11664.7667046659;11759.7648047039;11764.529418823236;11775.411229438536;11776.882231177664;11703.7074073148;11873.703157421047;11874.228175168673;11875.703107422298;11883.227590206609;11558.19092663514;11651.883481165165;11665.416729163508;11905.154701021269;11911.821322680167;41356;41507.377389339184;41771.58228417707;41847;41912;3317.4360358739073;3470.132466883279;3666.4683620874825;3686.7972261525606;3966.9999999999714;27882.442351152862;28835.71164288351;29552;29885.551716724265;29932.70067299321;2693.488237234939;2715.0633031604066;2754.380264440505;2785.777137828969;2818.6476690413697;366045;369802;370685.1465742681;370896;371208;38422.039449013995;39007.41488877669;39048;64979.67510162419;65331;37589.81205094012;37855;37963.43054854179;37977.860664180116;38010;16697.83302166987;16894.915525422293;16901;16905.830941690427;16962.575935601708;12828;13040.608781736562;13407.19556826574;13797.793033104512;13985.930070349787;8360.707375241838;8370.660694288885;8397.496150230883;8453.788655283544;8460.280876125475;3488.965110348915;3529.5235143255845;3531.311394278091;3537.5224344713133;3569.23261498779;1031.798799234157;1043.797587091237;1128.729105014807;1199.1665792274287;1233.8889499945049;30637.69362306393;30640.69359306423;30839.537406938915;31370.902018429246;31434.528482072787;964.6961207219704;986.787840614257;1184.9466773995018;1189.2270024483983;1199.8620158681688;11336.603218887465;14087.859121408655;15453.459128930659;15712.371505139667;15809.920950395404;625206;627173;630735;631218;631248;63074;63686.68156659187;63801.04298435527;63812.68093659502;63842.36157638364;1396.1553260277385;1415.4338264694;1547.0872185410437;1567.8588926996624;1570.6387530868192;27968;29370;29389.55915661224;29888.953886613865;29956.400871982874;61840.69079654573;63008.68495657492;63010;63029;63208;474388;483552;484353;484794;486036;36579.817100914326;42309;43110.784446078826;43851.9037024077;45688;42382.36426453544;43035.78482107569;43125.13749724925;44221.115577687626;44990.77504612456;36547.45178822373;36620.63379366279;36658.45012324871;36753;37230.81384593168;35841;35907.28185436329;36189;36498;36685.26629467342;36954.44568331531;37482.68810591616;37499.25001500009;37907.241855163295;38468.807655961544;26887;32019.153871754756;33410.832945835115;33686.15784605405;33699;24839.87580062088;24998.875005624854;25087.623685645096;25397.619035714848;25401.983920642968 20:28:07 INFO - PROCESS | 1957 | |2;jquery.html;345.59737905340273;412.3258472397631;412.81629674794726;413.1571593948345;423.86648205815163;15878.682426351466;19480.512987175327;20164.69752953705;20863.895680521597;20870.582588348225;17295.048772317517;18962.431127066175;20794.688079678817;20815.895920520376;20953.68569471459;5849.239598852154;6121.051237058263;6164.845878853042;6176.81469555914;6187.845303867417;4393.868183954486;6067.635941843481;6194;6197.225346831646;6197.2563292404975;6434.9678251608675;6748.527603067787;6758.22280437751;6759.797206083826;6772;6435.195600549931;6690.83272918176;6713.832154196135;6717.865642687143;6727;5842.386549412293;5867.706614669292;5875.618084824473;5879.118132280149;5883.117532370136;25051.49897002068;26324.947002119894;26333;26662.00034997383;27143.592846107324;2275.397019789757;2347.7534858839917;2380.7500212477785;2783.7890517624896;3050.908472745821;13700.862991370159;15077.924610376987;15375.92312038444;15618.984765990288;15725;1773.3704534890187;1815.373696074852;1875.3904980881132;1902.3341830359402;1908.5801123752751;114804.42597786957;115208;118032;118356.40821795922;119118.4044079774;9448;11044.171687123337;11426.600068997712;11628.94185529084;11706.239094458833;14576;14609.415623374945;14627.049241799248;14628.707425851424;14647.487337943121;8119.594020298961;8123.675052997932;8375.539345336065;9002.099790020946;9199.816003680024;9370.765730856783;9377.343585948918;9386.436813791195;9489.193418559362;9504.382215155993;6772.390484856386;6852.177738671391;6866.210385805596;6883.518153729291;6902.413294869892;1749.0467695106197;1935.551527317944;1945.785963544009;1946.338244996708;1956.1197461142542;869.8564736818354;1032.8140934631688;1054.3410368519676;1143.2854465958776;1184.3367714080143;16253.187340633158;21496.4625884351;21687.891560542095;21990.670139947913;22072.779272207394;930.2000279759402;1012.7417508535424;1043.9217058720474;1045.2369770067894;1069.6790962711154;10478.318909270873;10568.995945385175;10725.51735171919;10838.891611083945;10899.400532970763;651271;654532;659322;663049;667918;135853;140289;140403;140407;141924;1036.4247842447514;1097.6268068856787;1105.3920343810871;1107.020287045954;1109.91120710343;17901.462956111336;18011.459656210336;18113.547161321072;18164.545886352946;18908.621827563096;50855.74572127116;51005.234921475465;51011.44942752773;51315.717107072625;53277.73361133169;77247.61376193083;80856;84194.57902710447;85406.57296713477;85583.57208214168;7936.444448888522;8197.221263979913;8327.167283271625;8364.832703345777;8637.438566493158;10938.945305273422;11272.492737826653;12196.521123177126;12366.258024518558;12477.5008999639;10870;10921.453927303763;10952.452377381258;11215.943920280346;11242.437878105899;10714.785704285714;10853.565857365616;10971.615993440191;11201.887981120084;11253.987141157335;10755.946220268848;11086.057685096535;11325.546978120783;11409.429528523706;11532.135089868125;7990.8002299940645;8158.551279679675;8331.95834020826;8356.6239519223;8548.572571371531;9177.174054335143;10939.343639381663;11187.16096292765;11376.488058037574;11385.658430247106 20:28:07 INFO - PROCESS | 1957 | |3;mootools.html;1497.460914070935;1621.7350466636024;1638.7541868719695;1889.1970912362242;1991.2831380702944;8159.347252219823;8367.748967530968;8367.790805229872;8370.204830541104;8832.91167088329;8836.867446988284;8887.86668199976;8957.686480973167;8977.506237156953;9039.819203615923;2528.88620012099;2549.9745002550017;2550.502651982864;2553.1702196786027;2556.782673472757;2475.950480990379;2542.3008672615088;2549;2550.3241640965157;2551.400420901087;2494.5634513960076;2515.346010037385;2553.4254792671686;2556.169244995375;2562.987185064072;2507.949841003179;2545.350935511451;2545.643609894616;2547.8089143314232;2553.770160685538;2516.4086439686657;2544.122277814151;2546.1597672767944;2549.8852551635036;2566.6021766626204;9043.59303831329;9068.54657267134;9074;9080.591373388148;9089.318301127376;5466.781328746845;5583.720813959286;5710.914336284959;5745.741441635137;5763.193152958589;3067;3626.709863210937;3626.746127771057;3682.963170368289;3712.294664013829;1036.740814796301;1043.1498328861953;1051.111810520117;1068.513826209073;1089.3028461784463;11388.316700997884;11399.658010259705;11434.656960291122;11437.19939604228;11448.198626096177;4598.678092533558;4644.071185762861;4723.039938425583;4745.406824146981;4790.305405716222;9182.403143795633;9248.861267081;9253.53732313395;9257.814843703223;9297.581608827619;5455.208994695826;5468.070428027166;5470.234167216593;5478.45215478449;5488.4237155098135;4632.72203667781;4758.547937945889;4796.1127191468995;4807.61539076873;5100.260462232955;3406.982965085159;3731.9440208396895;3770.1328694399895;3867.013911452618;3988;1263.15999860092;1264.4562837979572;1269.955551555691;1276.2087505746497;1279.1493656718364;900.9909900901038;941.75985123793;950.12588418655;967.777411195429;1001.1940387987594;4996.550310472075;5949.25634295713;5950.077737950624;5966.612170208922;6056.606320589148;979.8628192053118;982.8009828009816;1007.3502590829021;1012.9797404051877;1037.1754455208127;3996.2407142642805;4074.2055299216963;4090.652294554996;4099.862347616857;4145.253854306194;10936.617218397318;11178.441077946232;11306.660800176009;11330.660080197607;11341.036011938913;10993.780124397626;11017.338959662446;11079.889201107886;11141.94151555601;11230.66308010761;8465.492070475668;8552.95723521391;8613.870791938127;8644.870326945102;8647.567621618893;5461;5776.682282474504;5855.882882342244;5879.941610510149;5992.516827174454;9974.700758977242;10009.24930630191;10158.18734501253;10160.593576257163;10164.186865050926;10019.298649094493;10232.48837558134;10333.379997200193;10392.37645741258;10426.530806113591;6489.805305840832;7265.4550908681;7282.089738782653;7348.889766653611;7352.705891764484;7930.762077137695;8735.344849136212;8745.387822852339;8755.91244087551;8760.430572013054;7447.441441891771;7561.168271490242;7562;7702.114256860533;7709.6530656119485;7527.435442341955;7527.736529221451;7575.431842611936;7602.201768814195;7620.314171724572;7169.032180655545;7245.38414234796;7252.492325537161;7253.818654533467;7294.416446684359;4924.365464476631;4951.306817045544;4987.775550100327;5048.848534543969;5074.213496907985;4906.55840974314;4987.680728461283;5009.448960614257;5094.414142373526;5244.003639308672 20:28:07 INFO - PROCESS | 1957 | |4;prototype.html;323.50988252797003;327.19346810113075;335.28918692372173;337.30683445519446;340.4977657954516;6625.668716564171;6644.30234825343;6650.667466626662;6694.230163531195;6705.932940670592;6333;6443;6525.086487891687;6526.477881769459;6652.368025037626;3918.45141680165;4890.7554622268835;4905.3132561441425;4925.70445773253;4936.555709986101;4000.399940008993;4899.363082799231;5001.424836143836;5002.324686167357;5002.899942001158;4691.202495575761;4705.929411058837;4875.975620121894;4928.531789480012;4941.160002799533;4441.977790111061;4848.418189817245;4848.903021939576;4873.488283730228;4896.143174944371;4094.9181016379803;4234.280172370704;4235.322348424237;4236.131593023453;4243.618074373321;5067.34124563808;5097.521718701572;6368.554201205918;6400.559874028353;6408.198975128109;5841.153032810261;5863.179154918314;5875.559333050039;5883.264436991098;5885.911711324334;6804.387605115514;7038.507304488688;7058.54119482232;7090.787276381717;7094.53885497441;4118.5057793065025;4727.66906316558;4761.47623761386;4773.570378665902;4787.497312782178;5957;7468.066491688539;7475.252474752536;7482.551046937201;7505.737299194502;4827.131116399011;4838.661293709407;4843.15244832153;4847;4851.466338702739;4912.361393018885;4922.163232250526;4923.90152196954;4924.852254432372;4927.655064145475;5451.427600102012;5701.230333904953;5823.330317013598;5828.358880523139;5842.510159909196;7078;7114.893276600855;7116.857662846714;7147.070880785464;7158.8210294742;1633.338497908349;1660.676168147224;1663.866890648745;1667.733162693963;1669.607642204081;914.3964983111115;959.8848138223318;976.799756050008;1045.3257648816623;1056.1339701444895;5210.687358758487;6723.361280678328;6737.494687898427;6932.133483314586;6946.340097690711;7337.559746415232;7344.375728063068;7348.5958272294465;7368.742094026683;7380.741674041383;6768.357006084414;6779.72881084761;6783.491238157158;6788.898166527407;6792.864142717217;3802.2015376770637;3841.3469710148784;3904.082540602956;3906.453096566483;3913.745606535566;7735.845283094307;7763.961180194063;7794.41541884361;7818.8827167592535;7830.608469576612;7622.313991740659;7677.078750549858;7688.115866675292;7694.961525192451;7709.768706938801;6310.652914089769;7781.027371578552;7783.104942931635;7801.999999999886;7803.687852485837;6690.732370705117;7221.4222862171955;7416.666250018654;7417.703291868481;7433.962830185815;7227.313405226495;7251.41988640918;7285.599292038989;7300.707971681073;7301.379382752525;7779;7789.376849852111;7801.414893883095;7801.570913599807;7804.882926756217;4645.814167433265;4716.410448693913;4717.315989181481;4720;4730.455997560324;7131.42948564124;7374.446916481178;7389.889151662622;7402.3707984821895;7403.037605111301;7140.571565706075;7173.569585824867;7185.245549217466;7186;7203.02759127532;5743.511801496919;7132.714691412285;7135.892961605477;7144.464165187528;7165.605891676008;6989.33601307875;7014.754483593049;7020.368166865007;7027.578345299298;7045.5420397676035;6887.862242755217;7138.179109402485;7152.749653762094;7186.496945213785;7194.532355396883;6712.865742685217;6881.827954301182;6888.41448476885;7020.543664661781;7040.436765058681 20:28:07 INFO - PROCESS | 1957 | |5;yui.html;653.8790323790099;779.7348901373533;782.1982467970327;783.5562701925036;795.8567457857583;15395;15548.53354399367;15634;15676.529704108867;15725.921370393145;14282.57152285433;14349.569512914602;14367.209803460806;14370.640733981629;14371;778.9337906277973;792.6512334572799;935.7988032572996;944.3295260365131;953.2516974175239;932.3054324528237;935.5135329628589;935.9391639543442;936.1387523478382;936.3258453913172;1001.2440607341483;1018.088810514589;1019.1490105761698;1021;1022.2180032275278;818.7912082418945;1011.2112552209288;1012.5139932832208;1012.6860673191334;1021.6168936648756;734.9081364829397;750.2010358967736;751.3988808952815;753.1639879733491;753.2919056087261;15050.774238386433;15078.246087695681;15106.093634381972;15121.773173402407;15136.621584460367;12871.292078935654;12874.29191394473;13058.2817945013;13109.934450327688;13474.93262533681;9945.403275803475;10133.341332813343;10170.338927969733;10613.57545698171;10780.838287425695;3547.3260080584605;3578.731595130376;3583.516225309576;3584.426491761306;3628.9455658165148;76865;78043.21956780473;78177;80403;80741.78887316636;10057.949710251549;10140;10161.441120738282;10256.43589602579;10450.709283533866;23135.190268340528;23140.884295578413;23152.18967336169;23170.8841455795;23210.419739506648;7668.846623067508;7810.804729881798;7848.725294614661;8035.638396272182;8045;4193.035601811601;4195.517515485697;4244.172386384687;4253.340732186516;4300.462442194726;3795.753276037104;3862.748921320105;3864.169203621235;3869.7810189790125;3869.9806500967316;593.1873333533088;687.189116842121;706.1173533083645;712.4834494991194;729.3690957321878;536.6994483089404;599.4361738958422;601.4406601860312;621.7823761683375;630.0486265738767;7879.251471110236;8388.790280243044;8403.41176117666;8534.103919088531;8540.572971351408;518.3960685801075;565.4515120333352;599.5084031094548;604.6523249131767;644.6035688051815;3225.193701574606;3543;4024.195160967818;4193.790310484464;4229.302165142779;70423;77565;77650.61174694091;77763.22236777673;83941;74032.62983685046;74343.62828185824;75460.62269688616;78758;78852.21147788448;68636;70427.94358084633;71115.64442177859;71403.99999999897;71938.64030679813;8321.292690121407;8532.274756645505;8612.18184272493;8626.654933802578;8647.221750042527;38306;47714.5228547724;49417.75291123521;49793.755156121384;50488.495115048376;68324;72265.91601126092;72413.39659335694;72448;73223.63388183025;8834.911650883409;10831.67504974852;11079.944600276947;11605.825912611486;11972.820407693718;11795.941020294844;11862.703432414259;12373.505059797508;12477.376131193223;12606;8543.359248056546;11202.43987800623;11321.716957075809;11542.19204655666;12018.158728888893;11420.600278990196;11437.199396042197;11623.535058597561;11850.229735067192;11962.282263063897;11162.107031437628;11323.263987840764;11478.827817582576;12005.579804707142;12194.878051219373;9499.952500237454;9668.274879383933;9827.557759900965;9868.753281168028;10135.949320253352;9566.596194503083;9895.20838332946;9908.058734420218;9932.801343973224;10013.899861001588 20:28:07 INFO - PROCESS | 1957 | __end_tp_report 20:28:07 INFO - PROCESS | 1957 | __start_cc_report 20:28:07 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,1211 20:28:07 INFO - PROCESS | 1957 | __end_cc_report 20:28:07 INFO - PROCESS | 1957 | __startTimestamp1468466887544__endTimestamp 20:28:07 INFO - PROCESS | 1957 | 20:28:07 INFO - PROCESS | 1957 | ------- Summary: start ------- 20:28:07 INFO - PROCESS | 1957 | Number of tests: 6 20:28:07 INFO - PROCESS | 1957 | 20:28:07 INFO - PROCESS | 1957 | [#0] dojo.html Cycles:165 Average:5896.43 Median:6151.85 stddev:637.38 (10.4%) stddev-sans-first:597.74 20:28:07 INFO - PROCESS | 1957 | Values: 3009.0 3601.4 3612.2 3629.5 3695.4 5954.5 5974.3 5974.4 5976.6 6014.1 5943.0 5999.6 5999.9 6000.9 6029.5 5214.4 5263.0 5352.4 5359.6 5405.7 5329.9 5359.1 5380.0 5381.9 5391.8 5305.4 5345.4 5354.2 5390.9 5397.7 5393.5 5393.5 5413.2 5421.4 5445.1 5146.7 5215.5 5309.5 5313.9 5346.1 5764.2 5772.3 5811.2 5840.2 5848.7 6247.2 6291.9 6304.6 6307.1 6317.1 6139.3 6230.9 6283.0 6361.5 6365.6 6020.0 6045.6 6063.7 6078.2 6084.9 6526.2 6535.7 6538.2 6546.1 6555.7 5826.6 6142.5 6143.3 6211.3 6245.2 6325.3 6343.0 6343.4 6344.5 6347.5 6166.5 6214.9 6216.1 6217.2 6238.9 6110.3 6148.1 6236.5 6238.8 6268.5 5000.9 5041.3 5048.3 5057.3 5062.7 4524.9 4579.2 4594.5 4602.9 4610.2 6034.1 6103.8 6109.1 6110.4 6135.8 6237.1 6238.7 6245.7 6247.5 6290.2 6130.1 6152.4 6167.8 6180.8 6188.5 5531.8 5567.6 5567.9 5589.9 5621.7 6414.6 6495.8 6540.5 6564.5 6598.3 6308.2 6328.8 6333.5 6342.3 6353.2 6579.4 6579.7 6599.4 6605.4 6622.4 6151.8 6162.5 6215.0 6265.4 6265.5 6254.0 6301.5 6303.9 6305.2 6332.9 6144.2 6245.7 6248.8 6292.1 6319.8 6158.3 6241.7 6255.7 6267.3 6277.8 6174.6 6179.5 6207.4 6213.9 6220.9 5095.4 6148.4 6219.1 6273.9 6300.1 6076.8 6132.2 6152.5 6179.1 6237.6 20:28:07 INFO - PROCESS | 1957 | 20:28:07 INFO - PROCESS | 1957 | [#1] ext.html Cycles:180 Average:63426.96 Median:36563.63 stddev:134862.20 (368.8%) stddev-sans-first:135157.83 20:28:07 INFO - PROCESS | 1957 | Values: 522.0 545.4 591.0 596.1 610.5 26082.7 38584.6 39563.0 39583.8 39626.0 42142.2 42683.1 42716.6 42819.0 42940.8 8989.9 9544.7 9737.5 9765.8 9776.9 11567.5 11822.5 11846.6 11848.9 11863.8 11664.8 11759.8 11764.5 11775.4 11776.9 11703.7 11873.7 11874.2 11875.7 11883.2 11558.2 11651.9 11665.4 11905.2 11911.8 41356.0 41507.4 41771.6 41847.0 41912.0 3317.4 3470.1 3666.5 3686.8 3967.0 27882.4 28835.7 29552.0 29885.6 29932.7 2693.5 2715.1 2754.4 2785.8 2818.6 366045.0 369802.0 370685.1 370896.0 371208.0 38422.0 39007.4 39048.0 64979.7 65331.0 37589.8 37855.0 37963.4 37977.9 38010.0 16697.8 16894.9 16901.0 16905.8 16962.6 12828.0 13040.6 13407.2 13797.8 13985.9 8360.7 8370.7 8397.5 8453.8 8460.3 3489.0 3529.5 3531.3 3537.5 3569.2 1031.8 1043.8 1128.7 1199.2 1233.9 30637.7 30640.7 30839.5 31370.9 31434.5 964.7 986.8 1184.9 1189.2 1199.9 11336.6 14087.9 15453.5 15712.4 15809.9 625206.0 627173.0 630735.0 631218.0 631248.0 63074.0 63686.7 63801.0 63812.7 63842.4 1396.2 1415.4 1547.1 1567.9 1570.6 27968.0 29370.0 29389.6 29889.0 29956.4 61840.7 63008.7 63010.0 63029.0 63208.0 474388.0 483552.0 484353.0 484794.0 486036.0 36579.8 42309.0 43110.8 43851.9 45688.0 42382.4 43035.8 43125.1 44221.1 44990.8 36547.5 36620.6 36658.5 36753.0 37230.8 35841.0 35907.3 36189.0 36498.0 36685.3 36954.4 37482.7 37499.3 37907.2 38468.8 26887.0 32019.2 33410.8 33686.2 33699.0 24839.9 24998.9 25087.6 25397.6 25402.0 20:28:07 INFO - PROCESS | 1957 | 20:28:07 INFO - PROCESS | 1957 | [#2] jquery.html Cycles:180 Average:37348.01 Median:20912.13 stddev:109753.36 (524.8%) stddev-sans-first:110026.08 20:28:07 INFO - PROCESS | 1957 | Values: 345.6 412.3 412.8 413.2 423.9 15878.7 19480.5 20164.7 20863.9 20870.6 17295.0 18962.4 20794.7 20815.9 20953.7 5849.2 6121.1 6164.8 6176.8 6187.8 4393.9 6067.6 6194.0 6197.2 6197.3 6435.0 6748.5 6758.2 6759.8 6772.0 6435.2 6690.8 6713.8 6717.9 6727.0 5842.4 5867.7 5875.6 5879.1 5883.1 25051.5 26324.9 26333.0 26662.0 27143.6 2275.4 2347.8 2380.8 2783.8 3050.9 13700.9 15077.9 15375.9 15619.0 15725.0 1773.4 1815.4 1875.4 1902.3 1908.6 114804.4 115208.0 118032.0 118356.4 119118.4 9448.0 11044.2 11426.6 11628.9 11706.2 14576.0 14609.4 14627.0 14628.7 14647.5 8119.6 8123.7 8375.5 9002.1 9199.8 9370.8 9377.3 9386.4 9489.2 9504.4 6772.4 6852.2 6866.2 6883.5 6902.4 1749.0 1935.6 1945.8 1946.3 1956.1 869.9 1032.8 1054.3 1143.3 1184.3 16253.2 21496.5 21687.9 21990.7 22072.8 930.2 1012.7 1043.9 1045.2 1069.7 10478.3 10569.0 10725.5 10838.9 10899.4 651271.0 654532.0 659322.0 663049.0 667918.0 135853.0 140289.0 140403.0 140407.0 141924.0 1036.4 1097.6 1105.4 1107.0 1109.9 17901.5 18011.5 18113.5 18164.5 18908.6 50855.7 51005.2 51011.4 51315.7 53277.7 77247.6 80856.0 84194.6 85406.6 85583.6 7936.4 8197.2 8327.2 8364.8 8637.4 10938.9 11272.5 12196.5 12366.3 12477.5 10870.0 10921.5 10952.5 11215.9 11242.4 10714.8 10853.6 10971.6 11201.9 11254.0 10755.9 11086.1 11325.5 11409.4 11532.1 7990.8 8158.6 8332.0 8356.6 8548.6 9177.2 10939.3 11187.2 11376.5 11385.7 20:28:07 INFO - PROCESS | 1957 | 20:28:07 INFO - PROCESS | 1957 | [#3] mootools.html Cycles:180 Average:5802.09 Median:4801.86 stddev:3207.29 (66.8%) stddev-sans-first:3199.97 20:28:07 INFO - PROCESS | 1957 | Values: 1497.5 1621.7 1638.8 1889.2 1991.3 8159.3 8367.7 8367.8 8370.2 8832.9 8836.9 8887.9 8957.7 8977.5 9039.8 2528.9 2550.0 2550.5 2553.2 2556.8 2476.0 2542.3 2549.0 2550.3 2551.4 2494.6 2515.3 2553.4 2556.2 2563.0 2507.9 2545.4 2545.6 2547.8 2553.8 2516.4 2544.1 2546.2 2549.9 2566.6 9043.6 9068.5 9074.0 9080.6 9089.3 5466.8 5583.7 5710.9 5745.7 5763.2 3067.0 3626.7 3626.7 3683.0 3712.3 1036.7 1043.1 1051.1 1068.5 1089.3 11388.3 11399.7 11434.7 11437.2 11448.2 4598.7 4644.1 4723.0 4745.4 4790.3 9182.4 9248.9 9253.5 9257.8 9297.6 5455.2 5468.1 5470.2 5478.5 5488.4 4632.7 4758.5 4796.1 4807.6 5100.3 3407.0 3731.9 3770.1 3867.0 3988.0 1263.2 1264.5 1270.0 1276.2 1279.1 901.0 941.8 950.1 967.8 1001.2 4996.6 5949.3 5950.1 5966.6 6056.6 979.9 982.8 1007.4 1013.0 1037.2 3996.2 4074.2 4090.7 4099.9 4145.3 10936.6 11178.4 11306.7 11330.7 11341.0 10993.8 11017.3 11079.9 11141.9 11230.7 8465.5 8553.0 8613.9 8644.9 8647.6 5461.0 5776.7 5855.9 5879.9 5992.5 9974.7 10009.2 10158.2 10160.6 10164.2 10019.3 10232.5 10333.4 10392.4 10426.5 6489.8 7265.5 7282.1 7348.9 7352.7 7930.8 8735.3 8745.4 8755.9 8760.4 7447.4 7561.2 7562.0 7702.1 7709.7 7527.4 7527.7 7575.4 7602.2 7620.3 7169.0 7245.4 7252.5 7253.8 7294.4 4924.4 4951.3 4987.8 5048.8 5074.2 4906.6 4987.7 5009.4 5094.4 5244.0 20:28:07 INFO - PROCESS | 1957 | 20:28:07 INFO - PROCESS | 1957 | [#4] prototype.html Cycles:180 Average:5821.12 Median:6700.08 stddev:1876.05 (28.0%) stddev-sans-first:1835.38 20:28:07 INFO - PROCESS | 1957 | Values: 323.5 327.2 335.3 337.3 340.5 6625.7 6644.3 6650.7 6694.2 6705.9 6333.0 6443.0 6525.1 6526.5 6652.4 3918.5 4890.8 4905.3 4925.7 4936.6 4000.4 4899.4 5001.4 5002.3 5002.9 4691.2 4705.9 4876.0 4928.5 4941.2 4442.0 4848.4 4848.9 4873.5 4896.1 4094.9 4234.3 4235.3 4236.1 4243.6 5067.3 5097.5 6368.6 6400.6 6408.2 5841.2 5863.2 5875.6 5883.3 5885.9 6804.4 7038.5 7058.5 7090.8 7094.5 4118.5 4727.7 4761.5 4773.6 4787.5 5957.0 7468.1 7475.3 7482.6 7505.7 4827.1 4838.7 4843.2 4847.0 4851.5 4912.4 4922.2 4923.9 4924.9 4927.7 5451.4 5701.2 5823.3 5828.4 5842.5 7078.0 7114.9 7116.9 7147.1 7158.8 1633.3 1660.7 1663.9 1667.7 1669.6 914.4 959.9 976.8 1045.3 1056.1 5210.7 6723.4 6737.5 6932.1 6946.3 7337.6 7344.4 7348.6 7368.7 7380.7 6768.4 6779.7 6783.5 6788.9 6792.9 3802.2 3841.3 3904.1 3906.5 3913.7 7735.8 7764.0 7794.4 7818.9 7830.6 7622.3 7677.1 7688.1 7695.0 7709.8 6310.7 7781.0 7783.1 7802.0 7803.7 6690.7 7221.4 7416.7 7417.7 7434.0 7227.3 7251.4 7285.6 7300.7 7301.4 7779.0 7789.4 7801.4 7801.6 7804.9 4645.8 4716.4 4717.3 4720.0 4730.5 7131.4 7374.4 7389.9 7402.4 7403.0 7140.6 7173.6 7185.2 7186.0 7203.0 5743.5 7132.7 7135.9 7144.5 7165.6 6989.3 7014.8 7020.4 7027.6 7045.5 6887.9 7138.2 7152.7 7186.5 7194.5 6712.9 6881.8 6888.4 7020.5 7040.4 20:28:07 INFO - PROCESS | 1957 | 20:28:07 INFO - PROCESS | 1957 | [#5] yui.html Cycles:180 Average:18012.86 Median:49605.75 stddev:24504.30 (49.4%) stddev-sans-first:24538.37 20:28:07 INFO - PROCESS | 1957 | Values: 653.9 779.7 782.2 783.6 795.9 15395.0 15548.5 15634.0 15676.5 15725.9 14282.6 14349.6 14367.2 14370.6 14371.0 778.9 792.7 935.8 944.3 953.3 932.3 935.5 935.9 936.1 936.3 1001.2 1018.1 1019.1 1021.0 1022.2 818.8 1011.2 1012.5 1012.7 1021.6 734.9 750.2 751.4 753.2 753.3 15050.8 15078.2 15106.1 15121.8 15136.6 12871.3 12874.3 13058.3 13109.9 13474.9 9945.4 10133.3 10170.3 10613.6 10780.8 3547.3 3578.7 3583.5 3584.4 3628.9 76865.0 78043.2 78177.0 80403.0 80741.8 10057.9 10140.0 10161.4 10256.4 10450.7 23135.2 23140.9 23152.2 23170.9 23210.4 7668.8 7810.8 7848.7 8035.6 8045.0 4193.0 4195.5 4244.2 4253.3 4300.5 3795.8 3862.7 3864.2 3869.8 3870.0 593.2 687.2 706.1 712.5 729.4 536.7 599.4 601.4 621.8 630.0 7879.3 8388.8 8403.4 8534.1 8540.6 518.4 565.5 599.5 604.7 644.6 3225.2 3543.0 4024.2 4193.8 4229.3 70423.0 77565.0 77650.6 77763.2 83941.0 74032.6 74343.6 75460.6 78758.0 78852.2 68636.0 70427.9 71115.6 71404.0 71938.6 8321.3 8532.3 8612.2 8626.7 8647.2 38306.0 47714.5 49417.8 49793.8 50488.5 68324.0 72265.9 72413.4 72448.0 73223.6 8834.9 10831.7 11079.9 11605.8 11972.8 11795.9 11862.7 12373.5 12477.4 12606.0 8543.4 11202.4 11321.7 11542.2 12018.2 11420.6 11437.2 11623.5 11850.2 11962.3 11162.1 11323.3 11478.8 12005.6 12194.9 9500.0 9668.3 9827.6 9868.8 10135.9 9566.6 9895.2 9908.1 9932.8 10013.9 20:28:07 INFO - PROCESS | 1957 | -------- Summary: end -------- 20:28:07 INFO - PROCESS | 1957 | 20:28:08 INFO - TEST-INFO | 1957: exit 0 20:28:08 INFO - TEST-OK | dromaeo_css | took 1113465ms 20:28:08 INFO - TEST-START | kraken 20:28:08 INFO - operating with platform_type : mac_ 20:28:08 INFO - Initialising browser for kraken test... 20:28:08 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpgZLMZ1/profile http://localhost:50331/getInfo.html) 20:28:10 INFO - PROCESS | 1960 | __metrics Screen width/height:1600/1200 20:28:10 INFO - PROCESS | 1960 | colorDepth:24 20:28:10 INFO - PROCESS | 1960 | Browser inner width/height: 1024/689 20:28:10 INFO - PROCESS | 1960 | __metrics 20:28:10 INFO - PROCESS | 1960 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:28:10 ERROR - PROCESS | 1960 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:28:10 INFO - TEST-INFO | 1960: exit 0 20:28:10 INFO - Browser initialized. 20:28:10 INFO - Running cycle 1/1 for kraken test... 20:28:10 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpgZLMZ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:22 INFO - PROCESS | 1963 | RSS: Main: 161918976 20:28:22 INFO - PROCESS | 1963 | 20:28:25 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50331/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:26 INFO - PROCESS | 1963 | RSS: Main: 223924224 20:28:26 INFO - PROCESS | 1963 | 20:28:28 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50331/tests/kraken/driver.html?testName=audio-dft) 20:28:29 INFO - PROCESS | 1963 | RSS: Main: 239353856 20:28:29 INFO - PROCESS | 1963 | 20:28:32 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50331/tests/kraken/driver.html?testName=audio-fft) 20:28:33 INFO - PROCESS | 1963 | RSS: Main: 325935104 20:28:33 INFO - PROCESS | 1963 | 20:28:35 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50331/tests/kraken/driver.html?testName=audio-oscillator) 20:28:35 INFO - PROCESS | 1963 | RSS: Main: 231223296 20:28:35 INFO - PROCESS | 1963 | 20:28:37 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50331/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:28:38 INFO - PROCESS | 1963 | RSS: Main: 232329216 20:28:38 INFO - PROCESS | 1963 | 20:28:41 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50331/tests/kraken/driver.html?testName=imaging-darkroom) 20:28:41 INFO - PROCESS | 1963 | RSS: Main: 268980224 20:28:41 INFO - PROCESS | 1963 | 20:28:44 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50331/tests/kraken/driver.html?testName=imaging-desaturate) 20:28:45 INFO - PROCESS | 1963 | RSS: Main: 270741504 20:28:45 INFO - PROCESS | 1963 | 20:28:47 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50331/tests/kraken/driver.html?testName=json-parse-financial) 20:28:48 INFO - PROCESS | 1963 | RSS: Main: 270385152 20:28:48 INFO - PROCESS | 1963 | 20:28:50 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50331/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:28:50 INFO - PROCESS | 1963 | RSS: Main: 260571136 20:28:50 INFO - PROCESS | 1963 | 20:28:52 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50331/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:28:53 INFO - PROCESS | 1963 | RSS: Main: 268201984 20:28:53 INFO - PROCESS | 1963 | 20:28:55 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50331/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:28:55 INFO - PROCESS | 1963 | RSS: Main: 271138816 20:28:55 INFO - PROCESS | 1963 | 20:28:58 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:28:59 INFO - PROCESS | 1963 | RSS: Main: 278323200 20:28:59 INFO - PROCESS | 1963 | 20:29:02 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:02 INFO - PROCESS | 1963 | RSS: Main: 275582976 20:29:02 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:50331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50331/tests/kraken/driver.html?testName=ai-astar) 20:29:04 INFO - PROCESS | 1963 | RSS: Main: 336232448 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | __start_tp_report 20:29:04 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 20:29:04 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 20:29:04 INFO - PROCESS | 1963 | |i|pagename|runs| 20:29:04 INFO - PROCESS | 1963 | |0;ai-astar;117;114;120;113;111;114;113;114;116;136 20:29:04 INFO - PROCESS | 1963 | |1;audio-beat-detection;154;120;141;164;115;138;149;143;212;129 20:29:04 INFO - PROCESS | 1963 | |2;audio-dft;184;185;182;187;185;184;185;184;183;182 20:29:04 INFO - PROCESS | 1963 | |3;audio-fft;69;82;73;156;55;57;56;66;129;55 20:29:04 INFO - PROCESS | 1963 | |4;audio-oscillator;92;90;143;79;87;88;125;79;78;125 20:29:04 INFO - PROCESS | 1963 | |5;imaging-gaussian-blur;90;86;90;87;89;86;89;88;90;86 20:29:04 INFO - PROCESS | 1963 | |6;imaging-darkroom;94;95;94;95;94;94;94;94;94;94 20:29:04 INFO - PROCESS | 1963 | |7;imaging-desaturate;87;84;84;83;85;86;86;85;85;84 20:29:04 INFO - PROCESS | 1963 | |8;json-parse-financial;61;63;62;62;63;63;63;76;58;56 20:29:04 INFO - PROCESS | 1963 | |9;json-stringify-tinderbox;61;66;61;70;70;72;70;67;66;66 20:29:04 INFO - PROCESS | 1963 | |10;stanford-crypto-aes;79;80;79;79;80;79;78;80;69;79 20:29:04 INFO - PROCESS | 1963 | |11;stanford-crypto-ccm;128;128;127;125;122;124;126;132;139;136 20:29:04 INFO - PROCESS | 1963 | |12;stanford-crypto-pbkdf2;164;167;165;175;166;170;162;167;163;162 20:29:04 INFO - PROCESS | 1963 | |13;stanford-crypto-sha256-iterative;67;68;68;67;68;66;68;69;66;65 20:29:04 INFO - PROCESS | 1963 | __end_tp_report 20:29:04 INFO - PROCESS | 1963 | __start_cc_report 20:29:04 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1989 20:29:04 INFO - PROCESS | 1963 | __end_cc_report 20:29:04 INFO - PROCESS | 1963 | __startTimestamp1468466944590__endTimestamp 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | ------- Summary: start ------- 20:29:04 INFO - PROCESS | 1963 | Number of tests: 14 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#0] ai-astar Cycles:10 Average:116.80 Median:115.00 stddev:7.19 (6.3%) stddev-sans-first:7.63 20:29:04 INFO - PROCESS | 1963 | Values: 117.0 114.0 120.0 113.0 111.0 114.0 113.0 114.0 116.0 136.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:146.00 stddev:27.44 (18.8%) stddev-sans-first:28.97 20:29:04 INFO - PROCESS | 1963 | Values: 154.0 120.0 141.0 164.0 115.0 138.0 149.0 143.0 212.0 129.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.52 (0.8%) stddev-sans-first:1.62 20:29:04 INFO - PROCESS | 1963 | Values: 184.0 185.0 182.0 187.0 185.0 184.0 185.0 184.0 183.0 182.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#3] audio-fft Cycles:10 Average:79.80 Median:61.50 stddev:34.80 (56.6%) stddev-sans-first:36.69 20:29:04 INFO - PROCESS | 1963 | Values: 69.0 82.0 73.0 156.0 55.0 57.0 56.0 66.0 129.0 55.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:83.00 stddev:23.39 (28.2%) stddev-sans-first:24.68 20:29:04 INFO - PROCESS | 1963 | Values: 92.0 90.0 143.0 79.0 87.0 88.0 125.0 79.0 78.0 125.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:89.00 stddev:1.73 (1.9%) stddev-sans-first:1.69 20:29:04 INFO - PROCESS | 1963 | Values: 90.0 86.0 90.0 87.0 89.0 86.0 89.0 88.0 90.0 86.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:29:04 INFO - PROCESS | 1963 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.20 (1.4%) stddev-sans-first:1.00 20:29:04 INFO - PROCESS | 1963 | Values: 87.0 84.0 84.0 83.0 85.0 86.0 86.0 85.0 85.0 84.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:5.25 (8.3%) stddev-sans-first:5.53 20:29:04 INFO - PROCESS | 1963 | Values: 61.0 63.0 62.0 62.0 63.0 63.0 63.0 76.0 58.0 56.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:68.50 stddev:3.75 (5.5%) stddev-sans-first:3.32 20:29:04 INFO - PROCESS | 1963 | Values: 61.0 66.0 61.0 70.0 70.0 72.0 70.0 67.0 66.0 66.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:79.00 stddev:3.29 (4.2%) stddev-sans-first:3.48 20:29:04 INFO - PROCESS | 1963 | Values: 79.0 80.0 79.0 79.0 80.0 79.0 78.0 80.0 69.0 79.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:128.00 stddev:5.40 (4.2%) stddev-sans-first:5.72 20:29:04 INFO - PROCESS | 1963 | Values: 128.0 128.0 127.0 125.0 122.0 124.0 126.0 132.0 139.0 136.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:166.50 stddev:4.01 (2.4%) stddev-sans-first:4.18 20:29:04 INFO - PROCESS | 1963 | Values: 164.0 167.0 165.0 175.0 166.0 170.0 162.0 167.0 163.0 162.0 20:29:04 INFO - PROCESS | 1963 | 20:29:04 INFO - PROCESS | 1963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 20:29:04 INFO - PROCESS | 1963 | Values: 67.0 68.0 68.0 67.0 68.0 66.0 68.0 69.0 66.0 65.0 20:29:04 INFO - PROCESS | 1963 | -------- Summary: end -------- 20:29:04 INFO - PROCESS | 1963 | 20:29:05 INFO - TEST-INFO | 1963: exit 0 20:29:05 INFO - TEST-OK | kraken | took 57254ms 20:29:05 INFO - SUITE-END | took 1170s 20:29:05 INFO - Completed test suite (00:19:31) 20:29:05 INFO - javascript benchmark 20:29:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3008.969910300897, 3601.4237721964473, 3612.241429299847, 3629.4555816627512, 3695.390260607, 5954.4640982311585, 5974.253218347707, 5974.372690867456, 5976.611520251186, 6014.127951447038, 5943.019401798698, 5999.640021598696, 5999.940000600003, 6000.909986350197, 6029.547783916213, 5214.400343960437, 5262.973685131578, 5352.437994010631, 5359.5712343012465, 5405.729713514309, 5329.946700533003, 5359.1425371940495, 5379.977804217206, 5381.946180538183, 5391.838244852661, 5305.4164041955355, 5345.3585569731495, 5354.22363757255, 5390.8921821563545, 5397.676139431627, 5393.487618676219, 5393.4876186762585, 5413.162195559475, 5421.403645598981, 5445.074337362658, 5146.6911985281, 5215.530602245778, 5309.548688361494, 5313.867153321159, 5346.064438723247, 5764.221830052931, 5772.278465191851, 5811.186433899257, 5840.182374467578, 5848.736806843703, 6247.187865577446, 6291.905621415683, 6304.621722696607, 6307.148534947815, 6317.084022816712, 6139.3388173831445, 6230.937690623081, 6283.0, 6361.459275961549, 6365.554411191219, 6019.969900150515, 6045.586721693188, 6063.6664983426335, 6078.209832721718, 6084.878302433926, 6526.2494813096155, 6535.705893234815, 6538.1500404947055, 6546.149000629887, 6555.737770489222, 5826.563007774434, 6142.529470848956, 6143.262808463013, 6211.3478084801345, 6245.219347581552, 6325.272593651697, 6342.968285158637, 6343.397377249154, 6344.49244060474, 6347.5239357047485, 6166.537509686791, 6214.875702486015, 6216.067589861557, 6217.222847144107, 6238.875222495615, 6110.285381942539, 6148.1085242639565, 6236.469900058546, 6238.844028899314, 6268.49852011838, 5000.924986125211, 5041.294218809369, 5048.268001139814, 5057.317262169634, 5062.746862656926, 4524.932126018112, 4579.22153233951, 4594.47163576193, 4602.907941841145, 4610.239310513794, 6034.08842306233, 6103.755849766048, 6109.083637454329, 6110.376504976068, 6135.754569817157, 6237.09562113491, 6238.656873871981, 6245.656488893063, 6247.468965137923, 6290.182276304051, 6130.141780150782, 6152.446279834837, 6167.814965551041, 6180.81457556274, 6188.4739797116845, 5531.778728850882, 5567.610267281251, 5567.860803479864, 5589.944100559023, 5621.662700237999, 6414.61512309263, 6495.772647957298, 6540.50946179048, 6564.507661925375, 6598.307177746459, 6308.179936608211, 6328.810135695937, 6333.493320534439, 6342.302346741947, 6353.237611486651, 6579.407853293226, 6579.703913323816, 6599.373059559334, 6605.372489613479, 6622.403983641495, 6151.84620384494, 6162.506999440124, 6214.968925155526, 6265.373462653698, 6265.530085243716, 6254.030625253093, 6301.527385446201, 6303.936960630518, 6305.180326557518, 6332.905006425, 6144.1567529740005, 6245.68771561411, 6248.812535623939, 6292.119103325446, 6319.842003949938, 6158.261008678808, 6241.719122639402, 6255.655938923403, 6267.2792628848265, 6277.843053923689, 6174.567780255518, 6179.536534759821, 6207.379262073757, 6213.9067913982235, 6220.906686399617, 5095.388553373619, 6148.415900489446, 6219.0982307566055, 6273.905891411724, 6300.054991751274, 6076.848078798065, 6132.226125838312, 6152.477039451696, 6179.073139029181, 6237.594556353823], "value": 5856.616733521298, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.9743204602955, 545.435474284116, 590.9540113998223, 596.052276879761, 610.5451438678185, 26082.739172608268, 38584.614153858456, 39562.99999999996, 39583.80208098955, 39626.0, 42142.15715685692, 42683.14633707324, 42716.57283427165, 42819.0, 42940.785296073474, 8989.910100898973, 9544.713658590235, 9737.464439455827, 9765.804683906317, 9776.902230977706, 11567.537298508092, 11822.527098916033, 11846.644600661994, 11848.881511184907, 11863.7627247455, 11664.7667046659, 11759.7648047039, 11764.529418823236, 11775.411229438536, 11776.882231177664, 11703.7074073148, 11873.703157421047, 11874.228175168673, 11875.703107422298, 11883.227590206609, 11558.19092663514, 11651.883481165165, 11665.416729163508, 11905.154701021269, 11911.821322680167, 41356.0, 41507.377389339184, 41771.58228417707, 41847.0, 41912.0, 3317.4360358739073, 3470.132466883279, 3666.4683620874825, 3686.7972261525606, 3966.9999999999714, 27882.442351152862, 28835.71164288351, 29552.0, 29885.551716724265, 29932.70067299321, 2693.488237234939, 2715.0633031604066, 2754.380264440505, 2785.777137828969, 2818.6476690413697, 366045.0, 369802.0, 370685.1465742681, 370896.0, 371208.0, 38422.039449013995, 39007.41488877669, 39048.0, 64979.67510162419, 65331.0, 37589.81205094012, 37855.0, 37963.43054854179, 37977.860664180116, 38010.0, 16697.83302166987, 16894.915525422293, 16901.0, 16905.830941690427, 16962.575935601708, 12828.0, 13040.608781736562, 13407.19556826574, 13797.793033104512, 13985.930070349787, 8360.707375241838, 8370.660694288885, 8397.496150230883, 8453.788655283544, 8460.280876125475, 3488.965110348915, 3529.5235143255845, 3531.311394278091, 3537.5224344713133, 3569.23261498779, 1031.798799234157, 1043.797587091237, 1128.729105014807, 1199.1665792274287, 1233.8889499945049, 30637.69362306393, 30640.69359306423, 30839.537406938915, 31370.902018429246, 31434.528482072787, 964.6961207219704, 986.787840614257, 1184.9466773995018, 1189.2270024483983, 1199.8620158681688, 11336.603218887465, 14087.859121408655, 15453.459128930659, 15712.371505139667, 15809.920950395404, 625206.0, 627173.0, 630735.0, 631218.0, 631248.0, 63074.0, 63686.68156659187, 63801.04298435527, 63812.68093659502, 63842.36157638364, 1396.1553260277385, 1415.4338264694, 1547.0872185410437, 1567.8588926996624, 1570.6387530868192, 27968.0, 29370.0, 29389.55915661224, 29888.953886613865, 29956.400871982874, 61840.69079654573, 63008.68495657492, 63010.0, 63029.0, 63208.0, 474388.0, 483552.0, 484353.0, 484794.0, 486036.0, 36579.817100914326, 42309.0, 43110.784446078826, 43851.9037024077, 45688.0, 42382.36426453544, 43035.78482107569, 43125.13749724925, 44221.115577687626, 44990.77504612456, 36547.45178822373, 36620.63379366279, 36658.45012324871, 36753.0, 37230.81384593168, 35841.0, 35907.28185436329, 36189.0, 36498.0, 36685.26629467342, 36954.44568331531, 37482.68810591616, 37499.25001500009, 37907.241855163295, 38468.807655961544, 26887.0, 32019.153871754756, 33410.832945835115, 33686.15784605405, 33699.0, 24839.87580062088, 24998.875005624854, 25087.623685645096, 25397.619035714848, 25401.983920642968], "value": 19344.675493819683, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.59737905340273, 412.3258472397631, 412.81629674794726, 413.1571593948345, 423.86648205815163, 15878.682426351466, 19480.512987175327, 20164.69752953705, 20863.895680521597, 20870.582588348225, 17295.048772317517, 18962.431127066175, 20794.688079678817, 20815.895920520376, 20953.68569471459, 5849.239598852154, 6121.051237058263, 6164.845878853042, 6176.81469555914, 6187.845303867417, 4393.868183954486, 6067.635941843481, 6194.0, 6197.225346831646, 6197.2563292404975, 6434.9678251608675, 6748.527603067787, 6758.22280437751, 6759.797206083826, 6772.0, 6435.195600549931, 6690.83272918176, 6713.832154196135, 6717.865642687143, 6727.0, 5842.386549412293, 5867.706614669292, 5875.618084824473, 5879.118132280149, 5883.117532370136, 25051.49897002068, 26324.947002119894, 26333.0, 26662.00034997383, 27143.592846107324, 2275.397019789757, 2347.7534858839917, 2380.7500212477785, 2783.7890517624896, 3050.908472745821, 13700.862991370159, 15077.924610376987, 15375.92312038444, 15618.984765990288, 15725.0, 1773.3704534890187, 1815.373696074852, 1875.3904980881132, 1902.3341830359402, 1908.5801123752751, 114804.42597786957, 115208.0, 118032.0, 118356.40821795922, 119118.4044079774, 9448.0, 11044.171687123337, 11426.600068997712, 11628.94185529084, 11706.239094458833, 14576.0, 14609.415623374945, 14627.049241799248, 14628.707425851424, 14647.487337943121, 8119.594020298961, 8123.675052997932, 8375.539345336065, 9002.099790020946, 9199.816003680024, 9370.765730856783, 9377.343585948918, 9386.436813791195, 9489.193418559362, 9504.382215155993, 6772.390484856386, 6852.177738671391, 6866.210385805596, 6883.518153729291, 6902.413294869892, 1749.0467695106197, 1935.551527317944, 1945.785963544009, 1946.338244996708, 1956.1197461142542, 869.8564736818354, 1032.8140934631688, 1054.3410368519676, 1143.2854465958776, 1184.3367714080143, 16253.187340633158, 21496.4625884351, 21687.891560542095, 21990.670139947913, 22072.779272207394, 930.2000279759402, 1012.7417508535424, 1043.9217058720474, 1045.2369770067894, 1069.6790962711154, 10478.318909270873, 10568.995945385175, 10725.51735171919, 10838.891611083945, 10899.400532970763, 651271.0, 654532.0, 659322.0, 663049.0, 667918.0, 135853.0, 140289.0, 140403.0, 140407.0, 141924.0, 1036.4247842447514, 1097.6268068856787, 1105.3920343810871, 1107.020287045954, 1109.91120710343, 17901.462956111336, 18011.459656210336, 18113.547161321072, 18164.545886352946, 18908.621827563096, 50855.74572127116, 51005.234921475465, 51011.44942752773, 51315.717107072625, 53277.73361133169, 77247.61376193083, 80856.0, 84194.57902710447, 85406.57296713477, 85583.57208214168, 7936.444448888522, 8197.221263979913, 8327.167283271625, 8364.832703345777, 8637.438566493158, 10938.945305273422, 11272.492737826653, 12196.521123177126, 12366.258024518558, 12477.5008999639, 10870.0, 10921.453927303763, 10952.452377381258, 11215.943920280346, 11242.437878105899, 10714.785704285714, 10853.565857365616, 10971.615993440191, 11201.887981120084, 11253.987141157335, 10755.946220268848, 11086.057685096535, 11325.546978120783, 11409.429528523706, 11532.135089868125, 7990.8002299940645, 8158.551279679675, 8331.95834020826, 8356.6239519223, 8548.572571371531, 9177.174054335143, 10939.343639381663, 11187.16096292765, 11376.488058037574, 11385.658430247106], "value": 10053.900596568177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.460914070935, 1621.7350466636024, 1638.7541868719695, 1889.1970912362242, 1991.2831380702944, 8159.347252219823, 8367.748967530968, 8367.790805229872, 8370.204830541104, 8832.91167088329, 8836.867446988284, 8887.86668199976, 8957.686480973167, 8977.506237156953, 9039.819203615923, 2528.88620012099, 2549.9745002550017, 2550.502651982864, 2553.1702196786027, 2556.782673472757, 2475.950480990379, 2542.3008672615088, 2549.0, 2550.3241640965157, 2551.400420901087, 2494.5634513960076, 2515.346010037385, 2553.4254792671686, 2556.169244995375, 2562.987185064072, 2507.949841003179, 2545.350935511451, 2545.643609894616, 2547.8089143314232, 2553.770160685538, 2516.4086439686657, 2544.122277814151, 2546.1597672767944, 2549.8852551635036, 2566.6021766626204, 9043.59303831329, 9068.54657267134, 9074.0, 9080.591373388148, 9089.318301127376, 5466.781328746845, 5583.720813959286, 5710.914336284959, 5745.741441635137, 5763.193152958589, 3067.0, 3626.709863210937, 3626.746127771057, 3682.963170368289, 3712.294664013829, 1036.740814796301, 1043.1498328861953, 1051.111810520117, 1068.513826209073, 1089.3028461784463, 11388.316700997884, 11399.658010259705, 11434.656960291122, 11437.19939604228, 11448.198626096177, 4598.678092533558, 4644.071185762861, 4723.039938425583, 4745.406824146981, 4790.305405716222, 9182.403143795633, 9248.861267081, 9253.53732313395, 9257.814843703223, 9297.581608827619, 5455.208994695826, 5468.070428027166, 5470.234167216593, 5478.45215478449, 5488.4237155098135, 4632.72203667781, 4758.547937945889, 4796.1127191468995, 4807.61539076873, 5100.260462232955, 3406.982965085159, 3731.9440208396895, 3770.1328694399895, 3867.013911452618, 3988.0, 1263.15999860092, 1264.4562837979572, 1269.955551555691, 1276.2087505746497, 1279.1493656718364, 900.9909900901038, 941.75985123793, 950.12588418655, 967.777411195429, 1001.1940387987594, 4996.550310472075, 5949.25634295713, 5950.077737950624, 5966.612170208922, 6056.606320589148, 979.8628192053118, 982.8009828009816, 1007.3502590829021, 1012.9797404051877, 1037.1754455208127, 3996.2407142642805, 4074.2055299216963, 4090.652294554996, 4099.862347616857, 4145.253854306194, 10936.617218397318, 11178.441077946232, 11306.660800176009, 11330.660080197607, 11341.036011938913, 10993.780124397626, 11017.338959662446, 11079.889201107886, 11141.94151555601, 11230.66308010761, 8465.492070475668, 8552.95723521391, 8613.870791938127, 8644.870326945102, 8647.567621618893, 5461.0, 5776.682282474504, 5855.882882342244, 5879.941610510149, 5992.516827174454, 9974.700758977242, 10009.24930630191, 10158.18734501253, 10160.593576257163, 10164.186865050926, 10019.298649094493, 10232.48837558134, 10333.379997200193, 10392.37645741258, 10426.530806113591, 6489.805305840832, 7265.4550908681, 7282.089738782653, 7348.889766653611, 7352.705891764484, 7930.762077137695, 8735.344849136212, 8745.387822852339, 8755.91244087551, 8760.430572013054, 7447.441441891771, 7561.168271490242, 7562.0, 7702.114256860533, 7709.6530656119485, 7527.435442341955, 7527.736529221451, 7575.431842611936, 7602.201768814195, 7620.314171724572, 7169.032180655545, 7245.38414234796, 7252.492325537161, 7253.818654533467, 7294.416446684359, 4924.365464476631, 4951.306817045544, 4987.775550100327, 5048.848534543969, 5074.213496907985, 4906.55840974314, 4987.680728461283, 5009.448960614257, 5094.414142373526, 5244.003639308672], "value": 4698.294265493045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.50988252797003, 327.19346810113075, 335.28918692372173, 337.30683445519446, 340.4977657954516, 6625.668716564171, 6644.30234825343, 6650.667466626662, 6694.230163531195, 6705.932940670592, 6333.0, 6443.0, 6525.086487891687, 6526.477881769459, 6652.368025037626, 3918.45141680165, 4890.7554622268835, 4905.3132561441425, 4925.70445773253, 4936.555709986101, 4000.399940008993, 4899.363082799231, 5001.424836143836, 5002.324686167357, 5002.899942001158, 4691.202495575761, 4705.929411058837, 4875.975620121894, 4928.531789480012, 4941.160002799533, 4441.977790111061, 4848.418189817245, 4848.903021939576, 4873.488283730228, 4896.143174944371, 4094.9181016379803, 4234.280172370704, 4235.322348424237, 4236.131593023453, 4243.618074373321, 5067.34124563808, 5097.521718701572, 6368.554201205918, 6400.559874028353, 6408.198975128109, 5841.153032810261, 5863.179154918314, 5875.559333050039, 5883.264436991098, 5885.911711324334, 6804.387605115514, 7038.507304488688, 7058.54119482232, 7090.787276381717, 7094.53885497441, 4118.5057793065025, 4727.66906316558, 4761.47623761386, 4773.570378665902, 4787.497312782178, 5957.0, 7468.066491688539, 7475.252474752536, 7482.551046937201, 7505.737299194502, 4827.131116399011, 4838.661293709407, 4843.15244832153, 4847.0, 4851.466338702739, 4912.361393018885, 4922.163232250526, 4923.90152196954, 4924.852254432372, 4927.655064145475, 5451.427600102012, 5701.230333904953, 5823.330317013598, 5828.358880523139, 5842.510159909196, 7078.0, 7114.893276600855, 7116.857662846714, 7147.070880785464, 7158.8210294742, 1633.338497908349, 1660.676168147224, 1663.866890648745, 1667.733162693963, 1669.607642204081, 914.3964983111115, 959.8848138223318, 976.799756050008, 1045.3257648816623, 1056.1339701444895, 5210.687358758487, 6723.361280678328, 6737.494687898427, 6932.133483314586, 6946.340097690711, 7337.559746415232, 7344.375728063068, 7348.5958272294465, 7368.742094026683, 7380.741674041383, 6768.357006084414, 6779.72881084761, 6783.491238157158, 6788.898166527407, 6792.864142717217, 3802.2015376770637, 3841.3469710148784, 3904.082540602956, 3906.453096566483, 3913.745606535566, 7735.845283094307, 7763.961180194063, 7794.41541884361, 7818.8827167592535, 7830.608469576612, 7622.313991740659, 7677.078750549858, 7688.115866675292, 7694.961525192451, 7709.768706938801, 6310.652914089769, 7781.027371578552, 7783.104942931635, 7801.999999999886, 7803.687852485837, 6690.732370705117, 7221.4222862171955, 7416.666250018654, 7417.703291868481, 7433.962830185815, 7227.313405226495, 7251.41988640918, 7285.599292038989, 7300.707971681073, 7301.379382752525, 7779.0, 7789.376849852111, 7801.414893883095, 7801.570913599807, 7804.882926756217, 4645.814167433265, 4716.410448693913, 4717.315989181481, 4720.0, 4730.455997560324, 7131.42948564124, 7374.446916481178, 7389.889151662622, 7402.3707984821895, 7403.037605111301, 7140.571565706075, 7173.569585824867, 7185.245549217466, 7186.0, 7203.02759127532, 5743.511801496919, 7132.714691412285, 7135.892961605477, 7144.464165187528, 7165.605891676008, 6989.33601307875, 7014.754483593049, 7020.368166865007, 7027.578345299298, 7045.5420397676035, 6887.862242755217, 7138.179109402485, 7152.749653762094, 7186.496945213785, 7194.532355396883, 6712.865742685217, 6881.827954301182, 6888.41448476885, 7020.543664661781, 7040.436765058681], "value": 5188.804653091106, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.8790323790099, 779.7348901373533, 782.1982467970327, 783.5562701925036, 795.8567457857583, 15395.0, 15548.53354399367, 15634.0, 15676.529704108867, 15725.921370393145, 14282.57152285433, 14349.569512914602, 14367.209803460806, 14370.640733981629, 14371.0, 778.9337906277973, 792.6512334572799, 935.7988032572996, 944.3295260365131, 953.2516974175239, 932.3054324528237, 935.5135329628589, 935.9391639543442, 936.1387523478382, 936.3258453913172, 1001.2440607341483, 1018.088810514589, 1019.1490105761698, 1021.0, 1022.2180032275278, 818.7912082418945, 1011.2112552209288, 1012.5139932832208, 1012.6860673191334, 1021.6168936648756, 734.9081364829397, 750.2010358967736, 751.3988808952815, 753.1639879733491, 753.2919056087261, 15050.774238386433, 15078.246087695681, 15106.093634381972, 15121.773173402407, 15136.621584460367, 12871.292078935654, 12874.29191394473, 13058.2817945013, 13109.934450327688, 13474.93262533681, 9945.403275803475, 10133.341332813343, 10170.338927969733, 10613.57545698171, 10780.838287425695, 3547.3260080584605, 3578.731595130376, 3583.516225309576, 3584.426491761306, 3628.9455658165148, 76865.0, 78043.21956780473, 78177.0, 80403.0, 80741.78887316636, 10057.949710251549, 10140.0, 10161.441120738282, 10256.43589602579, 10450.709283533866, 23135.190268340528, 23140.884295578413, 23152.18967336169, 23170.8841455795, 23210.419739506648, 7668.846623067508, 7810.804729881798, 7848.725294614661, 8035.638396272182, 8045.0, 4193.035601811601, 4195.517515485697, 4244.172386384687, 4253.340732186516, 4300.462442194726, 3795.753276037104, 3862.748921320105, 3864.169203621235, 3869.7810189790125, 3869.9806500967316, 593.1873333533088, 687.189116842121, 706.1173533083645, 712.4834494991194, 729.3690957321878, 536.6994483089404, 599.4361738958422, 601.4406601860312, 621.7823761683375, 630.0486265738767, 7879.251471110236, 8388.790280243044, 8403.41176117666, 8534.103919088531, 8540.572971351408, 518.3960685801075, 565.4515120333352, 599.5084031094548, 604.6523249131767, 644.6035688051815, 3225.193701574606, 3543.0, 4024.195160967818, 4193.790310484464, 4229.302165142779, 70423.0, 77565.0, 77650.61174694091, 77763.22236777673, 83941.0, 74032.62983685046, 74343.62828185824, 75460.62269688616, 78758.0, 78852.21147788448, 68636.0, 70427.94358084633, 71115.64442177859, 71403.99999999897, 71938.64030679813, 8321.292690121407, 8532.274756645505, 8612.18184272493, 8626.654933802578, 8647.221750042527, 38306.0, 47714.5228547724, 49417.75291123521, 49793.755156121384, 50488.495115048376, 68324.0, 72265.91601126092, 72413.39659335694, 72448.0, 73223.63388183025, 8834.911650883409, 10831.67504974852, 11079.944600276947, 11605.825912611486, 11972.820407693718, 11795.941020294844, 11862.703432414259, 12373.505059797508, 12477.376131193223, 12606.0, 8543.359248056546, 11202.43987800623, 11321.716957075809, 11542.19204655666, 12018.158728888893, 11420.600278990196, 11437.199396042197, 11623.535058597561, 11850.229735067192, 11962.282263063897, 11162.107031437628, 11323.263987840764, 11478.827817582576, 12005.579804707142, 12194.878051219373, 9499.952500237454, 9668.274879383933, 9827.557759900965, 9868.753281168028, 10135.949320253352, 9566.596194503083, 9895.20838332946, 9908.058734420218, 9932.801343973224, 10013.899861001588], "value": 7040.270572629579, "unit": "score"}], "name": "dromaeo_css", "value": 7618.378584379776, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 120.0, 113.0, 111.0, 114.0, 113.0, 114.0, 116.0, 136.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 141.0, 164.0, 115.0, 138.0, 149.0, 143.0, 212.0, 129.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 182.0, 187.0, 185.0, 184.0, 185.0, 184.0, 183.0, 182.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 73.0, 156.0, 55.0, 57.0, 56.0, 66.0, 129.0, 55.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 143.0, 79.0, 87.0, 88.0, 125.0, 79.0, 78.0, 125.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 90.0, 87.0, 89.0, 86.0, 89.0, 88.0, 90.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 84.0, 83.0, 85.0, 86.0, 86.0, 85.0, 85.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 76.0, 58.0, 56.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 66.0, 61.0, 70.0, 70.0, 72.0, 70.0, 67.0, 66.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 80.0, 79.0, 78.0, 80.0, 69.0, 79.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 127.0, 125.0, 122.0, 124.0, 126.0, 132.0, 139.0, 136.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 165.0, 175.0, 166.0, 170.0, 162.0, 167.0, 163.0, 162.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 66.0, 68.0, 69.0, 66.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1462.8, "alertThreshold": 2.0}]} 20:29:05 INFO - Return code: 0 20:29:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:29:05 ERROR - # TBPL SUCCESS # 20:29:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:29:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:29:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:29:05 INFO - 2016-07-13 20:29:05.891 screenresolution[1967:14330] starting screenresolution argv=screenresolution get 20:29:05 INFO - 2016-07-13 20:29:05.894 screenresolution[1967:14330] Display 0: 1600x1200x32@60 20:29:05 INFO - 2016-07-13 20:29:05.900 screenresolution[1968:14333] starting screenresolution argv=screenresolution list 20:29:05 INFO - Available Modes on Display 0 20:29:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:29:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:29:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:29:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:29:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:29:06 INFO - Intel Iris: 20:29:06 INFO - Chipset Model: Intel Iris 20:29:06 INFO - Type: GPU 20:29:06 INFO - Bus: Built-In 20:29:06 INFO - VRAM (Dynamic, Max): 1536 MB 20:29:06 INFO - Vendor: Intel (0x8086) 20:29:06 INFO - Device ID: 0x0a2e 20:29:06 INFO - Revision ID: 0x0009 20:29:06 INFO - Displays: 20:29:06 INFO - Display: 20:29:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:29:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:29:06 INFO - Display Serial Number: 1600x1200 60 20:29:06 INFO - Main Display: Yes 20:29:06 INFO - Mirror: Off 20:29:06 INFO - Online: Yes 20:29:06 INFO - Rotation: Supported 20:29:06 INFO - Return code: 0 20:29:06 INFO - Running post-action listener: _resource_record_post_action 20:29:06 INFO - Running post-run listener: _resource_record_post_run 20:29:07 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 1085440; Write bytes: 493784064; Read time: 11; Write time: 1941 20:29:07 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189022720; Write bytes: 188143616; Read time: 17338; Write time: 449 20:29:07 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 1085440; Write bytes: 294847488; Read time: 11; Write time: 1460 20:29:07 INFO - Running post-run listener: _upload_blobber_files 20:29:07 INFO - Blob upload gear active. 20:29:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:07 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:29:07 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:29:07 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:29:07 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:08 INFO - (blobuploader) - INFO - Done attempting. 20:29:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:29:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:09 INFO - (blobuploader) - INFO - Done attempting. 20:29:09 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:09 INFO - Return code: 0 20:29:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c54eb19d927ab0b14091fdb4cbb89a50e7474e1cfe03e0b7f44e97c0bce60938a75d8c74d23504cdbc55d0084c0d354b5be5bdfbca5c932b5702cdd090b9c68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f9297c3e56b69ca89c11f3bb13795040938e6fd88d6fa6e072c939a6846c1f315134ca56e231a462eedb4e1b63f5dc6c34721b860da3fe835ca597f7a423e653"} 20:29:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:09 INFO - Contents: 20:29:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c54eb19d927ab0b14091fdb4cbb89a50e7474e1cfe03e0b7f44e97c0bce60938a75d8c74d23504cdbc55d0084c0d354b5be5bdfbca5c932b5702cdd090b9c68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f9297c3e56b69ca89c11f3bb13795040938e6fd88d6fa6e072c939a6846c1f315134ca56e231a462eedb4e1b63f5dc6c34721b860da3fe835ca597f7a423e653"} 20:29:09 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:09 INFO - Copying logs to upload dir... 20:29:09 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.244763 ========= master_lag: 3.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-13 20:29:12.394303) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 20:29:12.397475) ========= 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.A3LWKBXwyv/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.52GInEPihf/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c54eb19d927ab0b14091fdb4cbb89a50e7474e1cfe03e0b7f44e97c0bce60938a75d8c74d23504cdbc55d0084c0d354b5be5bdfbca5c932b5702cdd090b9c68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f9297c3e56b69ca89c11f3bb13795040938e6fd88d6fa6e072c939a6846c1f315134ca56e231a462eedb4e1b63f5dc6c34721b860da3fe835ca597f7a423e653"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011214 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467964439/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c54eb19d927ab0b14091fdb4cbb89a50e7474e1cfe03e0b7f44e97c0bce60938a75d8c74d23504cdbc55d0084c0d354b5be5bdfbca5c932b5702cdd090b9c68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f9297c3e56b69ca89c11f3bb13795040938e6fd88d6fa6e072c939a6846c1f315134ca56e231a462eedb4e1b63f5dc6c34721b860da3fe835ca597f7a423e653"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 20:29:12.504858) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:29:12.505247) ========= 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.A3LWKBXwyv/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.52GInEPihf/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005272 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 20:29:12.533167) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 20:29:12.533503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 20:29:12.533833) ========= ========= Total master_lag: 3.33 =========