builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0378 starttime: 1467671581.78 results: success (0) buildid: 20160704064557 builduid: 27c77172f1ec4ef2807b5c6d2a070747 revision: ebaf4086c18c2d1e3f0af12ade55840413342bc3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:01.776813) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:01.777247) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:01.777527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:01.804878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:01.805161) ========= 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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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-04 15:33:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.10M=0.001s 2016-07-04 15:33:02 (8.10 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.646052 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.495327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.495694) ========= 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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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.020651 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:02.556328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 15:33:02.556640) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ebaf4086c18c2d1e3f0af12ade55840413342bc3 --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 ebaf4086c18c2d1e3f0af12ade55840413342bc3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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-04 15:33:02,636 truncating revision to first 12 chars 2016-07-04 15:33:02,636 Setting DEBUG logging. 2016-07-04 15:33:02,636 attempt 1/10 2016-07-04 15:33:02,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ebaf4086c18c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 15:33:03,506 unpacking tar archive at: mozilla-beta-ebaf4086c18c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.135802 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 15:33:03.717105) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:03.717401) ========= script_repo_revision: ebaf4086c18c2d1e3f0af12ade55840413342bc3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:03.717811) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:03.718081) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 15:33:03.736028) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-04 15:33:03.736423) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 15:33:03 INFO - MultiFileLogger online at 20160704 15:33:03 in /builds/slave/test 15:33:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:33:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:03 INFO - {'append_to_log': False, 15:33:03 INFO - 'base_work_dir': '/builds/slave/test', 15:33:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:33:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:03 INFO - 'branch': 'Mozilla-Beta', 15:33:03 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:03 INFO - 'config_files': ('talos/mac_config.py',), 15:33:03 INFO - 'default_actions': ('clobber', 15:33:03 INFO - 'read-buildbot-config', 15:33:03 INFO - 'download-and-extract', 15:33:03 INFO - 'populate-webroot', 15:33:03 INFO - 'create-virtualenv', 15:33:03 INFO - 'install', 15:33:03 INFO - 'run-tests'), 15:33:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:03 INFO - 'download_minidump_stackwalk': True, 15:33:03 INFO - 'download_symbols': 'ondemand', 15:33:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:03 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:03 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:03 INFO - 'installer_path': 'installer.exe', 15:33:03 INFO - 'log_level': 'info', 15:33:03 INFO - 'log_name': 'talos', 15:33:03 INFO - 'log_to_console': True, 15:33:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:33:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:33:03 INFO - 'opt_config_files': (), 15:33:03 INFO - 'pip_index': False, 15:33:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:03 INFO - 'cmd': ('bash', 15:33:03 INFO - '-c', 15:33:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:03 INFO - 'enabled': True, 15:33:03 INFO - 'halt_on_failure': False, 15:33:03 INFO - 'name': 'check_screen_resolution'},), 15:33:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:03 INFO - 'cmd': ('bash', 15:33:03 INFO - '-c', 15:33:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:03 INFO - 'enabled': True, 15:33:03 INFO - 'halt_on_failure': False, 15:33:03 INFO - 'name': 'check_screen_resolution'},), 15:33:03 INFO - 'run_cmd_checks_enabled': True, 15:33:03 INFO - 'sps_profile': False, 15:33:03 INFO - 'sps_profile_interval': 0, 15:33:03 INFO - 'suite': 'dromaeojs-e10s', 15:33:03 INFO - 'system_bits': '32', 15:33:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:03 INFO - 'title': 't-yosemite-r7-0378', 15:33:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:03 INFO - 'use_talos_json': True, 15:33:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:03 INFO - 'work_dir': 'build'} 15:33:03 INFO - ##### 15:33:03 INFO - ##### Running clobber step. 15:33:03 INFO - ##### 15:33:03 INFO - Running pre-action listener: _resource_record_pre_action 15:33:03 INFO - Running main action method: clobber 15:33:03 INFO - rmtree: /builds/slave/test/build 15:33:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:33:05 INFO - Running post-action listener: _resource_record_post_action 15:33:05 INFO - ##### 15:33:05 INFO - ##### Running read-buildbot-config step. 15:33:05 INFO - ##### 15:33:05 INFO - Running pre-action listener: _resource_record_pre_action 15:33:05 INFO - Running main action method: read_buildbot_config 15:33:05 INFO - Using buildbot properties: 15:33:05 INFO - { 15:33:05 INFO - "project": "", 15:33:05 INFO - "product": "firefox", 15:33:05 INFO - "script_repo_revision": "production", 15:33:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 15:33:05 INFO - "repository": "", 15:33:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 15:33:05 INFO - "buildid": "20160704064557", 15:33:05 INFO - "pgo_build": "False", 15:33:05 INFO - "basedir": "/builds/slave/test", 15:33:05 INFO - "buildnumber": 35, 15:33:05 INFO - "slavename": "t-yosemite-r7-0378", 15:33:05 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:33:05 INFO - "platform": "yosemite_r7", 15:33:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:33:05 INFO - "branch": "mozilla-beta", 15:33:05 INFO - "repo_path": "releases/mozilla-beta", 15:33:05 INFO - "revision": "ebaf4086c18c2d1e3f0af12ade55840413342bc3", 15:33:05 INFO - "stage_platform": "macosx64", 15:33:05 INFO - "builduid": "27c77172f1ec4ef2807b5c6d2a070747", 15:33:05 INFO - "slavebuilddir": "test" 15:33:05 INFO - } 15:33:05 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg. 15:33:05 INFO - Running post-action listener: _resource_record_post_action 15:33:05 INFO - ##### 15:33:05 INFO - ##### Running download-and-extract step. 15:33:05 INFO - ##### 15:33:05 INFO - Running pre-action listener: _resource_record_pre_action 15:33:05 INFO - Running main action method: download_and_extract 15:33:05 INFO - mkdir: /builds/slave/test/build/tests 15:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.test_packages.json 15:33:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 15:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/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 15:33:06 INFO - Downloaded 1165 bytes. 15:33:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 15:33:06 INFO - Using the following test package requirements: 15:33:06 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 15:33:06 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:06 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 15:33:06 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:06 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 15:33:06 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:33:06 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:06 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 15:33:06 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 15:33:06 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:06 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 15:33:06 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:06 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 15:33:06 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:06 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 15:33:06 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:33:06 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 15:33:06 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 15:33: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')]} 15:33:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.common.tests.zip 15:33:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 15:33:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/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 15:33:08 INFO - Downloaded 18351374 bytes. 15:33:08 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'] 15:33:08 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 15:33:11 INFO - Return code: 0 15:33:11 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 15:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:11 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.common.tests.zip 15:33:11 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 15:33:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/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 15:33:12 INFO - Downloaded 18351374 bytes. 15:33:12 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'] 15:33:12 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 15:33:15 INFO - Return code: 0 15:33:15 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')]} 15:33:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.talos.tests.zip 15:33:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 15:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/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 15:33:21 INFO - Downloaded 10840145 bytes. 15:33: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'] 15:33: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 15:33:21 INFO - Return code: 0 15:33: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')]} 15:33:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg 15:33:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 15:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 15:33:24 INFO - Downloaded 86196177 bytes. 15:33:24 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg 15:33:24 INFO - mkdir: /builds/slave/test/properties 15:33:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:33:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:33:24 INFO - Contents: 15:33:24 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg 15:33:25 INFO - Running post-action listener: _resource_record_post_action 15:33:25 INFO - Running post-action listener: set_extra_try_arguments 15:33:25 INFO - ##### 15:33:25 INFO - ##### Running populate-webroot step. 15:33:25 INFO - ##### 15:33:25 INFO - Running pre-action listener: _resource_record_pre_action 15:33:25 INFO - Running main action method: populate_webroot 15:33:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:33:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:33:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:33:25 INFO - '--tppagecycles', 15:33:25 INFO - '7'], 15:33:25 INFO - 'tests': ['tsvgm']}}, 15:33:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:33:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:33:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:33:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:33:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:33:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:33:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'talos_options': ['--disable-e10s'], 15:33:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'talos_options': ['--disable-e10s'], 15:33:25 INFO - 'tests': ['damp', 'tps']}, 15:33:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'tests': ['damp', 'tps']}, 15:33:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:33:25 INFO - 'tests': ['dromaeo_dom']}, 15:33:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:33:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:33:25 INFO - 'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore', 15:33:25 INFO - 'tabpaint']}, 15:33:25 INFO - 'other-e10s': {'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore', 15:33:25 INFO - 'tabpaint']}, 15:33:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore', 15:33:25 INFO - 'tabpaint']}, 15:33:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore', 15:33:25 INFO - 'tabpaint']}, 15:33:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:33:25 INFO - 'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore', 15:33:25 INFO - 'tabpaint']}, 15:33:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:33:25 INFO - 'tests': ['a11yr', 15:33:25 INFO - 'ts_paint', 15:33:25 INFO - 'tpaint', 15:33:25 INFO - 'sessionrestore', 15:33:25 INFO - 'sessionrestore_no_auto_restore', 15:33:25 INFO - 'tabpaint']}, 15:33:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:33:25 INFO - 'tests': ['tsvgx', 15:33:25 INFO - 'tsvgr_opacity', 15:33:25 INFO - 'tart', 15:33:25 INFO - 'tscrollx', 15:33:25 INFO - 'cart']}, 15:33:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:33:25 INFO - 'tsvgr_opacity', 15:33:25 INFO - 'tart', 15:33:25 INFO - 'tscrollx', 15:33:25 INFO - 'cart']}, 15:33:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'talos_options': ['--disable-e10s'], 15:33:25 INFO - 'tests': ['tp5o']}, 15:33:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'tests': ['tp5o']}, 15:33:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'talos_options': ['--disable-e10s', 15:33:25 INFO - '--xperf_path', 15:33:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:25 INFO - 'tests': ['tp5n']}, 15:33:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:25 INFO - 'talos_options': ['--xperf_path', 15:33:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:25 INFO - 'tests': ['tp5n']}}, 15:33:25 INFO - 'talos.zip': {'path': '', 15:33:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:33:25 INFO - Running post-action listener: _resource_record_post_action 15:33:25 INFO - ##### 15:33:25 INFO - ##### Running create-virtualenv step. 15:33:25 INFO - ##### 15:33:25 INFO - Running pre-action listener: _resource_record_pre_action 15:33:25 INFO - Running main action method: create_virtualenv 15:33:25 INFO - Creating virtualenv /builds/slave/test/build/venv 15:33:25 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 15:33:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:33:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:33:25 INFO - Using real prefix '/tools/python27' 15:33:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:33:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:33:28 INFO - Installing pip.................done. 15:33:28 INFO - Return code: 0 15:33:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1045bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045cf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb694cf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10445ee00>, '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 0x1042c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104459b20>, '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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 15:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZBMO0XkOYL/Render', 15:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:28 INFO - 'HOME': '/Users/cltbld', 15:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:28 INFO - 'LOGNAME': 'cltbld', 15:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:28 INFO - 'MOZ_NO_REMOTE': '1', 15:33:28 INFO - 'NO_EM_RESTART': '1', 15:33:28 INFO - 'PAGER': '/bin/cat', 15:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:28 INFO - 'PWD': '/builds/slave/test', 15:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:28 INFO - 'SHELL': '/bin/bash', 15:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PT8xR1V1Nt/Listeners', 15:33:28 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 15:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:28 INFO - 'USER': 'cltbld', 15:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:28 INFO - 'XPC_FLAGS': '0x0', 15:33:28 INFO - 'XPC_SERVICE_NAME': '0', 15:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:28 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 15:33:28 INFO - Cleaning up... 15:33:28 INFO - Return code: 0 15:33:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1045bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045cf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb694cf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10445ee00>, '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 0x1042c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104459b20>, '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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 15:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:33:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZBMO0XkOYL/Render', 15:33:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:29 INFO - 'HOME': '/Users/cltbld', 15:33:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:29 INFO - 'LOGNAME': 'cltbld', 15:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:29 INFO - 'MOZ_NO_REMOTE': '1', 15:33:29 INFO - 'NO_EM_RESTART': '1', 15:33:29 INFO - 'PAGER': '/bin/cat', 15:33:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:29 INFO - 'PWD': '/builds/slave/test', 15:33:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:29 INFO - 'SHELL': '/bin/bash', 15:33:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PT8xR1V1Nt/Listeners', 15:33:29 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 15:33:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:29 INFO - 'USER': 'cltbld', 15:33:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:29 INFO - 'XPC_FLAGS': '0x0', 15:33:29 INFO - 'XPC_SERVICE_NAME': '0', 15:33:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:29 INFO - Downloading/unpacking psutil>=0.7.1 15:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:33:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:33 INFO - Installing collected packages: psutil 15:33:33 INFO - Running setup.py install for psutil 15:33:33 INFO - building 'psutil._psutil_osx' extension 15:33:33 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 15:33:33 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 15:33:33 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 15:33:33 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 15:33:33 INFO - building 'psutil._psutil_posix' extension 15:33:33 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 15:33:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:33:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:33:33 INFO - ^ 15:33:33 INFO - 1 warning generated. 15:33:33 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 15:33:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:33 INFO - Successfully installed psutil 15:33:33 INFO - Cleaning up... 15:33:34 INFO - Return code: 0 15:33:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1045bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045cf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb694cf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10445ee00>, '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 0x1042c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104459b20>, '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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 15:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZBMO0XkOYL/Render', 15:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:34 INFO - 'HOME': '/Users/cltbld', 15:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:34 INFO - 'LOGNAME': 'cltbld', 15:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:34 INFO - 'MOZ_NO_REMOTE': '1', 15:33:34 INFO - 'NO_EM_RESTART': '1', 15:33:34 INFO - 'PAGER': '/bin/cat', 15:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:34 INFO - 'PWD': '/builds/slave/test', 15:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:34 INFO - 'SHELL': '/bin/bash', 15:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PT8xR1V1Nt/Listeners', 15:33:34 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 15:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:34 INFO - 'USER': 'cltbld', 15:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:34 INFO - 'XPC_FLAGS': '0x0', 15:33:34 INFO - 'XPC_SERVICE_NAME': '0', 15:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:33:36 INFO - Installing collected packages: mozsystemmonitor 15:33:36 INFO - Running setup.py install for mozsystemmonitor 15:33:36 INFO - Successfully installed mozsystemmonitor 15:33:36 INFO - Cleaning up... 15:33:37 INFO - Return code: 0 15:33:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:33:37 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')]} 15:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:37 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')]} 15:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:37 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 0x1045bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045cf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb694cf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10445ee00>, '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 0x1042c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104459b20>, '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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 15:33:37 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 15:33:37 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 15:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZBMO0XkOYL/Render', 15:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:37 INFO - 'HOME': '/Users/cltbld', 15:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:37 INFO - 'LOGNAME': 'cltbld', 15:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:37 INFO - 'MOZ_NO_REMOTE': '1', 15:33:37 INFO - 'NO_EM_RESTART': '1', 15:33:37 INFO - 'PAGER': '/bin/cat', 15:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:37 INFO - 'PWD': '/builds/slave/test', 15:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:37 INFO - 'SHELL': '/bin/bash', 15:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PT8xR1V1Nt/Listeners', 15:33:37 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 15:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:37 INFO - 'USER': 'cltbld', 15:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:37 INFO - 'XPC_FLAGS': '0x0', 15:33:37 INFO - 'XPC_SERVICE_NAME': '0', 15:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:33:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 INFO - Downloading docopt-0.6.1.tar.gz 15:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:40 INFO - Running setup.py install for blobuploader 15:33:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:33:41 INFO - Running setup.py install for requests 15:33:41 INFO - Running setup.py install for docopt 15:33:41 INFO - Successfully installed blobuploader requests docopt 15:33:41 INFO - Cleaning up... 15:33:41 INFO - Return code: 0 15:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:41 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')]} 15:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 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')]} 15:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 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 0x1045bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045cf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb694cf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10445ee00>, '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 0x1042c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104459b20>, '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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 15:33:41 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 15:33:41 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 15:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZBMO0XkOYL/Render', 15:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:41 INFO - 'HOME': '/Users/cltbld', 15:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:41 INFO - 'LOGNAME': 'cltbld', 15:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:41 INFO - 'MOZ_NO_REMOTE': '1', 15:33:41 INFO - 'NO_EM_RESTART': '1', 15:33:41 INFO - 'PAGER': '/bin/cat', 15:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:41 INFO - 'PWD': '/builds/slave/test', 15:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:41 INFO - 'SHELL': '/bin/bash', 15:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PT8xR1V1Nt/Listeners', 15:33:41 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 15:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:41 INFO - 'USER': 'cltbld', 15:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:41 INFO - 'XPC_FLAGS': '0x0', 15:33:41 INFO - 'XPC_SERVICE_NAME': '0', 15:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:42 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-HLs2Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:42 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-kfUR_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:42 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-s8nAZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:42 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-SvnBN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:42 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-XvoFAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:42 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-dug6eV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:42 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-2DCLJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:42 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-jIW3Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:42 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-Rf4b8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:42 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-bF8mO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:43 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-QOfEVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:43 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-B2aAbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:43 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-dI9MoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:43 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-kTS9AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:43 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-v7BKqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:43 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-E1489B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:43 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-JEWRqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:43 INFO - Running setup.py install for manifestparser 15:33:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:33:43 INFO - Running setup.py install for mozcrash 15:33:44 INFO - Running setup.py install for mozdebug 15:33:44 INFO - Running setup.py install for mozdevice 15:33:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:33:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:33:44 INFO - Running setup.py install for mozfile 15:33:44 INFO - Running setup.py install for mozhttpd 15:33:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:33:44 INFO - Running setup.py install for mozinfo 15:33:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:33:44 INFO - Running setup.py install for mozInstall 15:33:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:33:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:33:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:33:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:33:44 INFO - Running setup.py install for mozleak 15:33:45 INFO - Running setup.py install for mozlog 15:33:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:33:45 INFO - Running setup.py install for moznetwork 15:33:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:33:45 INFO - Running setup.py install for mozprocess 15:33:45 INFO - Running setup.py install for mozprofile 15:33:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:33:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:33:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:33:45 INFO - Running setup.py install for mozrunner 15:33:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:33:45 INFO - Running setup.py install for mozscreenshot 15:33:46 INFO - Running setup.py install for moztest 15:33:46 INFO - Running setup.py install for mozversion 15:33:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:33:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:46 INFO - Cleaning up... 15:33:46 INFO - Return code: 0 15:33:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:46 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')]} 15:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:46 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')]} 15:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:46 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 0x1045bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045cf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb694cf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10445ee00>, '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 0x1042c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104459b20>, '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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 15:33:46 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 15:33:46 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 15:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZBMO0XkOYL/Render', 15:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:46 INFO - 'HOME': '/Users/cltbld', 15:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:46 INFO - 'LOGNAME': 'cltbld', 15:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:46 INFO - 'MOZ_NO_REMOTE': '1', 15:33:46 INFO - 'NO_EM_RESTART': '1', 15:33:46 INFO - 'PAGER': '/bin/cat', 15:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:46 INFO - 'PWD': '/builds/slave/test', 15:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:46 INFO - 'SHELL': '/bin/bash', 15:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PT8xR1V1Nt/Listeners', 15:33:46 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 15:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:46 INFO - 'USER': 'cltbld', 15:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:46 INFO - 'XPC_FLAGS': '0x0', 15:33:46 INFO - 'XPC_SERVICE_NAME': '0', 15:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:46 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-HdBcOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:46 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)) 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:46 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-_TVB3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:46 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)) 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:46 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-JZmIPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:46 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)) 15:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:46 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-Qz4_t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:47 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)) 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:47 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-tlx0Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:47 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)) 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:47 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-2yNP7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:47 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)) 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:47 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-u6tiNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:47 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)) 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:47 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-p6NrgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:47 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)) 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:47 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-kVRSFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:47 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)) 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:47 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-1kjDZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:47 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)) 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:47 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-VKiaV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:47 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)) 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:47 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-R7OA4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:47 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)) 15:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:47 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-SD6MFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:48 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)) 15:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:48 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-fKE3fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:48 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)) 15:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:48 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-4FrU6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:48 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)) 15:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:48 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-qsbWXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:48 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)) 15:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:48 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-qSMReL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:48 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)) 15:33:48 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)) 15:33:48 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)) 15:33:48 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)) 15:33:48 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)) 15:33:48 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)) 15:33:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:48 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 15:33:48 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 15:33:48 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 15:33:48 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 15:33:48 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 15:33:48 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 15:33:50 INFO - Downloading blessings-1.6.tar.gz 15:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:50 INFO - Installing collected packages: blessings 15:33:50 INFO - Running setup.py install for blessings 15:33:51 INFO - Successfully installed blessings 15:33:51 INFO - Cleaning up... 15:33:51 INFO - Return code: 0 15:33:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:51 INFO - Reading from file tmpfile_stdout 15:33:51 INFO - Current package versions: 15:33:51 INFO - blessings == 1.6 15:33:51 INFO - blobuploader == 1.2.4 15:33:51 INFO - docopt == 0.6.1 15:33:51 INFO - manifestparser == 1.1 15:33:51 INFO - mozInstall == 1.12 15:33:51 INFO - mozcrash == 0.17 15:33:51 INFO - mozdebug == 0.1 15:33:51 INFO - mozdevice == 0.48 15:33:51 INFO - mozfile == 1.2 15:33:51 INFO - mozhttpd == 0.7 15:33:51 INFO - mozinfo == 0.9 15:33:51 INFO - mozleak == 0.1 15:33:51 INFO - mozlog == 3.1 15:33:51 INFO - moznetwork == 0.27 15:33:51 INFO - mozprocess == 0.22 15:33:51 INFO - mozprofile == 0.28 15:33:51 INFO - mozrunner == 6.11 15:33:51 INFO - mozscreenshot == 0.1 15:33:51 INFO - mozsystemmonitor == 0.0 15:33:51 INFO - moztest == 0.7 15:33:51 INFO - mozversion == 1.4 15:33:51 INFO - psutil == 3.1.1 15:33:51 INFO - requests == 1.2.3 15:33:51 INFO - wsgiref == 0.1.2 15:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:51 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')]} 15:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:51 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')]} 15:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:51 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 0x1045bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045cf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb694cf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10445ee00>, '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 0x1042c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104459b20>, '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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 15:33:51 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 15:33:51 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 15:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZBMO0XkOYL/Render', 15:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:51 INFO - 'HOME': '/Users/cltbld', 15:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:51 INFO - 'LOGNAME': 'cltbld', 15:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:51 INFO - 'MOZ_NO_REMOTE': '1', 15:33:51 INFO - 'NO_EM_RESTART': '1', 15:33:51 INFO - 'PAGER': '/bin/cat', 15:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:51 INFO - 'PWD': '/builds/slave/test', 15:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:51 INFO - 'SHELL': '/bin/bash', 15:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PT8xR1V1Nt/Listeners', 15:33:51 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 15:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:51 INFO - 'USER': 'cltbld', 15:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:51 INFO - 'XPC_FLAGS': '0x0', 15:33:51 INFO - 'XPC_SERVICE_NAME': '0', 15:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:51 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)) 15:33:51 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)) 15:33:51 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)) 15:33:51 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)) 15:33:51 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)) 15:33:51 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)) 15:33:51 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)) 15:33:51 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)) 15:33:51 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)) 15:33:51 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)) 15:33:51 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)) 15:33:51 INFO - Cleaning up... 15:33:51 INFO - Return code: 0 15:33:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:33:51 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')]} 15:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:51 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')]} 15:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:51 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 0x1045bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045cf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb694cf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10445ee00>, '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 0x1042c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104459b20>, '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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 15:33:51 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 15:33:51 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 15:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZBMO0XkOYL/Render', 15:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:51 INFO - 'HOME': '/Users/cltbld', 15:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:51 INFO - 'LOGNAME': 'cltbld', 15:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:51 INFO - 'MOZ_NO_REMOTE': '1', 15:33:51 INFO - 'NO_EM_RESTART': '1', 15:33:51 INFO - 'PAGER': '/bin/cat', 15:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:51 INFO - 'PWD': '/builds/slave/test', 15:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:51 INFO - 'SHELL': '/bin/bash', 15:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PT8xR1V1Nt/Listeners', 15:33:51 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 15:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:51 INFO - 'USER': 'cltbld', 15:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:51 INFO - 'XPC_FLAGS': '0x0', 15:33:51 INFO - 'XPC_SERVICE_NAME': '0', 15:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:52 INFO - Downloading/unpacking jsonschema 15:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:33:54 INFO - Downloading/unpacking functools32 (from jsonschema) 15:33:54 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 15:33:54 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 15:33:54 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 15:33:54 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 15:33:54 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 15:33:54 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 15:33:55 INFO - Downloading functools32-3.2.3-2.tar.gz 15:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:33:55 INFO - warning: no files found matching '*.txt' 15:33:55 INFO - no previously-included directories found matching 'build' 15:33:55 INFO - no previously-included directories found matching 'dist' 15:33:55 INFO - no previously-included directories found matching '.git*' 15:33:55 INFO - Installing collected packages: jsonschema, functools32 15:33:55 INFO - Running setup.py install for functools32 15:33:55 INFO - warning: no files found matching '*.txt' 15:33:55 INFO - no previously-included directories found matching 'build' 15:33:55 INFO - no previously-included directories found matching 'dist' 15:33:55 INFO - no previously-included directories found matching '.git*' 15:33:55 INFO - Successfully installed jsonschema functools32 15:33:55 INFO - Cleaning up... 15:33:55 INFO - Return code: 0 15:33:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:33:55 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')]} 15:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:55 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')]} 15:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:55 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 0x1045bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045cf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb694cf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10445ee00>, '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 0x1042c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104459b20>, '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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 15:33:55 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 15:33:55 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 15:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZBMO0XkOYL/Render', 15:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:55 INFO - 'HOME': '/Users/cltbld', 15:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:55 INFO - 'LOGNAME': 'cltbld', 15:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:55 INFO - 'MOZ_NO_REMOTE': '1', 15:33:55 INFO - 'NO_EM_RESTART': '1', 15:33:55 INFO - 'PAGER': '/bin/cat', 15:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:55 INFO - 'PWD': '/builds/slave/test', 15:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:55 INFO - 'SHELL': '/bin/bash', 15:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PT8xR1V1Nt/Listeners', 15:33:55 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 15:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:55 INFO - 'USER': 'cltbld', 15:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:55 INFO - 'XPC_FLAGS': '0x0', 15:33:55 INFO - 'XPC_SERVICE_NAME': '0', 15:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:55 INFO - Downloading/unpacking flake8 15:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:33:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:33:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:58 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 15:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:33:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:33:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:33:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:33:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:33:59 INFO - no previously-included directories found matching 'docs/_build' 15:33:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:33:59 INFO - Running setup.py install for pep8 15:33:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:33:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:33:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:33:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:33:59 INFO - no previously-included directories found matching 'docs/_build' 15:33:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:33:59 INFO - Cleaning up... 15:33:59 INFO - Return code: 0 15:33:59 INFO - Running post-action listener: _resource_record_post_action 15:33:59 INFO - Running post-action listener: _start_resource_monitoring 15:33:59 INFO - Starting resource monitoring. 15:33:59 INFO - ##### 15:33:59 INFO - ##### Running install step. 15:33:59 INFO - ##### 15:33:59 INFO - Running pre-action listener: _resource_record_pre_action 15:33:59 INFO - Running main action method: install 15:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:00 INFO - Reading from file tmpfile_stdout 15:34:00 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:00 INFO - Reading from file tmpfile_stdout 15:34:00 INFO - Output received: 15:34:00 INFO - Usage: mozinstall [options] installer 15:34:00 INFO - Options: 15:34:00 INFO - -h, --help show this help message and exit 15:34:00 INFO - -d DEST, --destination=DEST 15:34:00 INFO - Directory to install application into. [default: 15:34:00 INFO - "/builds/slave/test"] 15:34:00 INFO - --app=APP Application being installed. [default: firefox] 15:34:00 INFO - mkdir: /builds/slave/test/build/application 15:34:00 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'] 15:34:00 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 15:34:21 INFO - Reading from file tmpfile_stdout 15:34:21 INFO - Output received: 15:34:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:34:21 INFO - Running post-action listener: _resource_record_post_action 15:34:21 INFO - ##### 15:34:21 INFO - ##### Running run-tests step. 15:34:21 INFO - ##### 15:34:21 INFO - Running pre-action listener: _resource_record_pre_action 15:34:21 INFO - Running main action method: run_tests 15:34:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:34:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:34:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:34:21 INFO - 2016-07-04 15:34:21.936 screenresolution[1999:11801] starting screenresolution argv=screenresolution get 15:34:21 INFO - 2016-07-04 15:34:21.939 screenresolution[1999:11801] Display 0: 1600x1200x32@60 15:34:21 INFO - 2016-07-04 15:34:21.944 screenresolution[2000:11803] starting screenresolution argv=screenresolution list 15:34:21 INFO - Available Modes on Display 0 15:34:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:34:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:34:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:34:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:34:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:34:22 INFO - Intel Iris: 15:34:22 INFO - Chipset Model: Intel Iris 15:34:22 INFO - Type: GPU 15:34:22 INFO - Bus: Built-In 15:34:22 INFO - VRAM (Dynamic, Max): 1536 MB 15:34:22 INFO - Vendor: Intel (0x8086) 15:34:22 INFO - Device ID: 0x0a2e 15:34:22 INFO - Revision ID: 0x0009 15:34:22 INFO - Displays: 15:34:22 INFO - Display: 15:34:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:34:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:34:22 INFO - Display Serial Number: 1600x1200 60 15:34:22 INFO - Main Display: Yes 15:34:22 INFO - Mirror: Off 15:34:22 INFO - Online: Yes 15:34:22 INFO - Rotation: Supported 15:34:22 INFO - Return code: 0 15:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:34:22 INFO - Python 2.7.3 15:34:22 INFO - Return code: 0 15:34:22 INFO - grabbing minidump binary from tooltool 15:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:22 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 0x10445ee00>, '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 0x1042c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104459b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:34:22 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 15:34:22 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 15:34:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:34:22 INFO - Return code: 0 15:34:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:34:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:34:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:34:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:34:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:34:23 INFO - Return code: 0 15:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0378', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0378 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZBMO0XkOYL/Render', 15:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:23 INFO - 'HOME': '/Users/cltbld', 15:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:23 INFO - 'LOGNAME': 'cltbld', 15:34:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:34:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:23 INFO - 'MOZ_NO_REMOTE': '1', 15:34:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:34:23 INFO - 'NO_EM_RESTART': '1', 15:34:23 INFO - 'PAGER': '/bin/cat', 15:34:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:23 INFO - 'PWD': '/builds/slave/test', 15:34:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:23 INFO - 'SHELL': '/bin/bash', 15:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PT8xR1V1Nt/Listeners', 15:34:23 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 15:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:23 INFO - 'USER': 'cltbld', 15:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:23 INFO - 'XPC_FLAGS': '0x0', 15:34:23 INFO - 'XPC_SERVICE_NAME': '0', 15:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0378', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:34:23 INFO - mozversion application_buildid: 20160704064557 15:34:23 INFO - mozversion application_changeset: ebaf4086c18c2d1e3f0af12ade55840413342bc3 15:34:23 INFO - mozversion application_display_name: Firefox 15:34:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:34:23 INFO - mozversion application_name: Firefox 15:34:23 INFO - mozversion application_remotingname: firefox 15:34:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:34:23 INFO - mozversion application_vendor: Mozilla 15:34:23 INFO - mozversion application_version: 48.0 15:34:23 INFO - mozversion platform_buildid: 20160704064557 15:34:23 INFO - mozversion platform_changeset: ebaf4086c18c2d1e3f0af12ade55840413342bc3 15:34:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:34:23 INFO - mozversion platform_version: 48.0 15:34:23 INFO - using testdate: 1467671663 15:34:23 INFO - actual date: 1467671663 15:34:23 INFO - starting webserver on 'localhost:49399' 15:34:23 INFO - SUITE-START | Running 2 tests 15:34:23 INFO - TEST-START | dromaeo_css 15:34:23 INFO - operating with platform_type : mac_ 15:34:23 INFO - Initialising browser for dromaeo_css test... 15:34:23 INFO - TEST-INFO | started process 2018 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpBkhuOd/profile http://localhost:49399/getInfo.html) 15:34:26 INFO - PROCESS | 2018 | __metrics Screen width/height:1600/1200 15:34:26 INFO - PROCESS | 2018 | colorDepth:24 15:34:26 INFO - PROCESS | 2018 | Browser inner width/height: 1024/689 15:34:26 INFO - PROCESS | 2018 | __metrics 15:34:26 ERROR - PROCESS | 2018 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 15:34:26 INFO - TEST-INFO | 2018: exit 0 15:34:26 INFO - Browser initialized. 15:34:26 INFO - Running cycle 1/1 for dromaeo_css test... 15:34:26 INFO - TEST-INFO | started process 2022 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpBkhuOd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:38 INFO - PROCESS | 2022 | RSS: Main: 171610112 15:34:38 INFO - PROCESS | 2022 | 15:35:28 INFO - PROCESS | 2022 | 1467671728324 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] 15:37:38 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49399/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49399/tests/dromaeo/cssquery-ext.html) 15:37:39 INFO - PROCESS | 2022 | RSS: Main: 182157312 15:37:39 INFO - PROCESS | 2022 | 15:40:41 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49399/tests/dromaeo/cssquery-ext.html (next: http://localhost:49399/tests/dromaeo/cssquery-jquery.html) 15:40:42 INFO - PROCESS | 2022 | RSS: Main: 193667072 15:40:42 INFO - PROCESS | 2022 | 15:43:43 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49399/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49399/tests/dromaeo/cssquery-mootools.html) 15:43:44 INFO - PROCESS | 2022 | RSS: Main: 195067904 15:43:44 INFO - PROCESS | 2022 | 15:46:45 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49399/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49399/tests/dromaeo/cssquery-prototype.html) 15:46:46 INFO - PROCESS | 2022 | RSS: Main: 198774784 15:46:46 INFO - PROCESS | 2022 | 15:49:49 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49399/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49399/tests/dromaeo/cssquery-yui.html) 15:49:49 INFO - PROCESS | 2022 | RSS: Main: 197849088 15:49:49 INFO - PROCESS | 2022 | 15:52:51 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49399/tests/dromaeo/cssquery-yui.html (next: http://localhost:49399/tests/dromaeo/cssquery-dojo.html) 15:52:52 INFO - PROCESS | 2022 | RSS: Main: 203497472 15:52:52 INFO - PROCESS | 2022 | 15:52:52 INFO - PROCESS | 2022 | __start_tp_report 15:52:52 INFO - PROCESS | 2022 | _x_x_mozilla_page_load 15:52:52 INFO - PROCESS | 2022 | _x_x_mozilla_page_load_details 15:52:52 INFO - PROCESS | 2022 | |i|pagename|runs| 15:52:52 INFO - PROCESS | 2022 | |0;dojo.html;2794.4411117776444;3608.5489313835756;3651.47053677217;3668.1563240454693;3681.3189559931416;5869.178315035899;5890.676012819294;5901.616394934326;5913.852153696154;5966.761329546818;5934.88130237395;5955.2853657561045;5968.522518198544;5993.970030149843;6030.969845150779;5248.370195576526;5295.655782374152;5360.061989151883;5373.274607927919;5413.458654134574;4547.726636541774;5275.498827611371;5306.389765176996;5363.6245462817615;5419.430959749228;4370.781460926957;5380.7309634518315;5399.19012148177;5403.8108666196695;5449.809256676017;5209.583233341362;5341.278927344836;5357.142857142878;5365.543928766059;5413.377461591908;5188.662736922088;5241.449647786965;5276.155815069609;5280.683159010433;5331.2003199519995;4815.940493091514;5260.763265653055;5800.941990580082;5803.651780893118;5819.24349834523;6153.230846144232;6190.195274614316;6253.843653908643;6264.3422440643535;6289.559730818844;5161.380634323905;5641.717914104278;6195.513076861565;6325.0828629848875;6345.302016778151;6015.789447369321;6020.2775666919815;6027.457528822383;6035.517158627387;6045.788397406113;5565.888682226414;6212.409821067082;6301.842453938597;6449.645269510128;6483.1847082816885;6219.595726277777;6221.9377806221355;6233.2208473940755;6251.624902505864;6257.56197066201;6339.587926784837;6353.8729225416155;6354.8411289717205;6384.840378990562;6390.169277993831;6125.20492926512;6184.165137706352;6221.097940798559;6233.594816336924;6266.248050234001;5293.391260005149;6199.752009919553;6248.875022499525;6249.25008998923;6260.812175634647;4994.051130285234;4994.775235114428;5043.798248070036;5078.289039534468;5089.796408143633;3574.428091505347;3857.517810273716;3905.7851818149707;4474.127545128734;4534.546545345439;5936;5992.0712289595185;6103.084537319438;6105.421132926843;6134.283518479771;5335.279737235501;5857.26784151981;6295.194803903069;6307.306196318401;6328.778492752732;4889.779959901813;6061.727222275008;6112.663803490851;6114.785982490592;6128.509719222451;5482.890342193134;5506.669599824023;5542.057850165482;5542.91685624716;5555.472230138131;6365.52258580599;6592.76925307612;6597.670116494156;6598.406143447113;6612.735490580323;5631.267935168402;6250.781222657185;6306.148669929501;6311.274203466476;6352.36476352361;6529.542931994714;6553.639549824806;6584.308647591934;6588.308227636221;6604.778116048355;6151.72317245716;6187.81436556904;6282.089097080806;6285.43431091204;6285.465735412358;6259.374062593704;6266.592671476339;6321.051842223703;6328.46208072319;6342.429181373698;6093.329733729375;6199.473044791243;6228.688565571794;6230.470410015199;6262.937370626418;6130.306415576139;6152.200213972155;6210.689465526615;6239.78160764371;6254.3745625437095;6110.7555697771595;6138.324784273816;6142.815715528542;6172.938270617236;6195.380461953949;5731.799387021434;6233.937660623335;6245.7813976512425;6259.561830671809;6276.466500347522;6040.788572399945;6102.511799055976;6112.419320164578;6119.051547010221;6137.140800288053 15:52:52 INFO - PROCESS | 2022 | |1;ext.html;516.6951498615816;517.800646751001;527.6148411659489;530.4350866327361;677.8271540757106;39176.82469525915;40282.59717402829;40324;40419.79790101053;40471.98820029501;41510.792446037725;41709.16581668365;42258.577414225845;42279.154416911646;42368.36447453291;9581.90418095817;9786.021397860228;9835.803283934318;9835.95082024589;9853.211743060538;9634.421934683907;9858.063483969012;9883.55524001418;9932.354396964174;9968.6510972116;9878.703638890845;9903.059209375135;9921.40471571708;9923.40459572428;9927.900720992806;9820.65627703034;9847.507624618776;9878.851817222747;9898.851517227247;9918.851217231748;9816.901830981671;9865.210783137332;9902.306838521306;9943.204543636564;9956.303058785888;33626.32747345064;40245.59754402448;40397.394039089144;40523.18953620941;40635.796821015705;2961.363306889029;3220.4203243416177;3284.6222684391364;3325.185329594265;3425.2293234022395;30214.395712085636;30286.697133028607;30325;31166.065018049496;31167.688323116705;2776.083892315531;2836.092450415868;2839.9858000709864;2942.7792915531422;2968.3469636679897;378323;379132;384452;385605;387534;39199.020024499616;68320.6583967077;68750;69585.65207174033;73571.63214183894;34118.147046323546;38600;38917.80541097277;39292;39292.60707392889;16689.91655041717;16801.495955121365;16903.661926761397;16938.153092345332;17208.741868871977;14156.85843141576;14308.713825723635;14312;14332.283385830875;14342.211178385289;8432.831343373098;8484.745457636282;8606.31149508038;8926.196642302224;8941.865872011926;3704.7406681532034;3724.1062145084984;3729.850805967785;3730.515033045687;3732.664060234592;1013.108464551205;1022.2690776095128;1036.2797855490512;1164.644783341072;1166.9066474682006;30690.53964190539;30830;31277.8436107818;31469.527957080663;31526.527102093485;1130.1015692524463;1130.7455822439886;1139.5384869128015;1173.096715529038;1241.1436109084702;13210.801837972438;14624.85375146235;14893.957263077817;15078.170700611572;15400.845991539942;557230;615683;619543;625492;627933;56974.715126424104;57551.71224143852;58202.708986454796;59000.70499647474;59133.113003304985;1579.88940774147;1597.7523483859788;1601.3434491858281;1608.4933246027465;1677.547062293174;29416.852915735286;29590.40819183647;29683.703162968093;30131.397372051997;30211.244718882204;44567.55432445764;52517.7374113127;52813.735931320094;53708;53869;559457;563844.1807790935;563886;564749;565479;24362.51274974455;26984;28042.85978570094;28201.294967625974;28483.715162848108;45504.54495455003;46401.07197856092;46639.83400414881;47642.285365720236;47808.282875756195;36860.89417317485;38732.6126738729;38744.41883371808;39362.80318598389;39504.407433887936;37941.86174414772;37951.24097517979;37969;38804.80597597107;38818.6118138815;32761.836190819846;37531.624683752816;37886.810565946995;38274.61725382822;38506.0373490665;28220.457127548147;35229.64770352366;35313.47029794606;35325.82337088298;35367.78242886584;20453.2841350552;25507.107251246118;25520.872395637904;25591.360215994006;25826.225213243633 15:52:52 INFO - PROCESS | 2022 | |2;jquery.html;374.24215962675584;409.4533797380497;413.9958600413995;416.2465936654654;427.51904107878636;16131.758023629654;20737.688934665974;21436.57126857464;21448.356549303528;21698.023588938497;20645.690314645293;21144.788552114474;21199.04604292807;21536.353909382706;21561.245356412528;5665.943340566593;5776.451237132465;5836.358000619928;5961.374055724152;5980.222571065756;5715.428457154293;5855.970720146393;5891.234139561872;6010.789622363218;6038.909416358758;4952.281919121743;5989.550783691218;6005.669688167149;6034.577579569432;6037.516998640098;5760.7695692172265;5784.219130417403;5867.70661466925;5881.85295367615;5904.5276377890095;4655.4878963314;5577.061217974301;5969.224000879901;5997.070454079625;6016.007358785839;20971.895140524353;23608.763912360828;24932.626010609856;24942.37644058895;26215.737842621522;2248.1119957616816;2333.0667732906973;2383.2254517281954;2589.935251618706;2631.644727961739;9937.354071985297;10368.792624147474;10757.62348317813;11592.536298548048;15000.624984375369;1691.9407820726215;1734.3929624631278;1761.445144779403;1805.2147315917618;1840.2271046160645;113077.43461282642;113708;114833.42583287113;115663.2650510243;120251;10445.477726113664;11473.483693233824;11686;11740.647780566596;12189.634310970685;15127.54617361481;15207.543773686586;15279.930404871775;15301.387944482318;15347.462838800588;8713;9063.637454501877;9162.312826537904;9166;9243.445393276425;7692.884606730903;9283.767905802273;9329.253659707207;9338;9344.719658410258;4674.813007479731;4728.385309909759;4774.570288674036;4793.01743142655;4847.224444088929;2003.3789525246927;2044.396902913644;2046.8464865134877;2066.3077868914083;2068.917243310281;919.6137622198693;945.6784693204344;966.79213968997;1001.4041645221082;1094.4240293976648;18121.54696132581;20020.49948751293;20249.39251822448;20252.392428227176;20811.479713007295;909.8953620333614;930.297625292913;932.5989824375583;1070.03162138265;1075.0808059109506;8999.37004409685;10982.780344393228;11001.339919604688;11024.559017639365;11052.889471105185;591494;645682;662682;663424;665660;116168;136588.63411365758;138865;139452;141701;1044.4882007816116;1112.4326593437243;1117.463617463622;1119.513011839836;1125.1224045244721;15269.6182595436;17630.82369176292;18401.815981840547;18564.071796409855;18598;48820.26769598388;51129.2104776331;52651.47348526466;54440.18339724828;55360;74638;79380.80928785958;79661.60169199349;79836.40327193307;81074;6986.615736134561;7788.376929845485;8005.9599702001115;8061.677532898853;8078.555679437687;8991.831061961902;11570.826437603611;12197.817032744339;12380.752384952071;12409.875901241234;9736.561854716412;9980.351277166961;10840.186985975926;11012.614558490735;11162.051225645911;10427.478626068818;10557.366558006544;10570.154387648816;10816.188785840935;10860.619878304222;10259.487025648838;10898.836517452086;11155.219134660496;11174.27367221128;11277.71805704864;8084.070331911906;8106.657122404948;8139.79650508742;8179.754607361789;8296.294814940798;8083.070446898682;9442.905570944478;9958.701238962843;10871.510782014986;11042.503087360927 15:52:52 INFO - PROCESS | 2022 | |3;mootools.html;1483.1546018769302;1662.8004639443266;1885.1893685715145;1989.621971825353;2026.0680087159906;7389.298016688419;8037.5579343136105;9043.593038313275;9128.361014728971;9259.490728009956;8858.822823543525;8865.95567022164;8955.86566201506;8967.327450441211;8998.910010899888;2530.430653103051;2531.1267612673596;2561.602951542505;2565.8973641054336;2567.550678631241;2523.0916869926814;2542.2627438043037;2575.3432874616947;2582;2584.1084825735184;2533.505966336565;2559.7696207341337;2561.782248508879;2564.948701025978;2572.7298633643477;2382;2483.7392073832257;2536.7970562355154;2570.9228723138335;2594.286571192918;2544.6691930048974;2577.8453292802305;2595.299269197325;2596.1692258477296;2612;9117.81764364709;9135.040820713795;9160.725178244664;9175.908240917572;9223.07769223079;5609.326880774333;5714.200011998323;5763.106718458645;5769.423057694239;5772.595918285721;3670.229251857113;3730.776153430803;3742.9812850935573;3743.2513497300647;3856.1709232515145;1056.313396292416;1067.8520590365388;1070.882202957674;1079.1528650009705;1084.5932775209296;10578.788424231472;11945.880541194563;12109.576164834276;12153.69615759613;12386.256824590553;4882.316475693406;4895.192293271642;5046.167382381939;5052.9747351263;5147.562457191106;10459.95400459948;10517.211209159344;10554.525046372932;10564.524596393027;10566.366018038942;5609.635373700697;5611.915821262684;5665.3201615806365;5743.483086522149;5805.506531944832;4596.49438561758;5027.572656324181;5126.512981266774;5145.3568303962;5177.922331165036;4262.957370426256;4325.6755743318745;4340.2187606230555;4367.148406060851;4376.387305777193;1404.9789253161211;1435.9497417590335;1440.8343040550471;1446.24795106544;1461.4154338264566;822.3051521464353;914.6752902719438;915.2540679346445;929.4887811703671;972.4797233480055;5928.4960778334325;6029.468302352123;6046.102656847967;6071.605345652607;6201;939.9624015039459;956.4357029352715;980.5048450532436;1012.8176928153003;1040.8594839696696;3571.714262859017;3973.960260397359;4040.8383664653084;4134.276501612206;4160.667146628262;10808.919108089285;10814;10828.296160749525;10899.237053406345;10938.179636527293;10853.294535855144;10906.945465272624;11062.446877656084;11090;11127.666170014912;7361.889571656429;7490.689129402442;8178.427510074238;8206.343492520704;8345.040320363114;5603.691796951207;5664.801731939362;5731;5731.627444216113;5935.495482884004;9256.444613322952;9399.295052870926;9428.434293942386;9480.146786788946;9842.11420972116;9518.286128540249;9648.98685638026;9786.070323319273;9891.703248902544;9898.158656514277;7608.467407281659;7707.421943354383;7752.0697516298405;7838.451308408356;7906.288434040964;8340.666373344999;8371.623276952674;8481.448705834102;8514.914850851412;8567.61445734931;7399.59302238382;7558.206388329147;7584.582847943196;7631.3513351365755;7981.1619779924595;7057.117860267466;7136.286371362822;7285.344319011102;7385.150707668687;7550.735724249625;6929.965350173418;7090.503664743418;7119.644017799193;7128.429725622042;7185.137783466018;4883.169861123689;4901.607871370353;5012.77442515095;5035.496450354935;5053.216751403538;4330.805113769951;5010.023045506091;5047.974760126176;5097.0315640028275;5239.580833533384 15:52:52 INFO - PROCESS | 2022 | |4;prototype.html;338.4990214482566;339.8148009334912;342.6299596435849;345.3801670166917;352.36574166500327;6537.7058032388595;7028.367446929776;7068.505204635671;7080.96459517703;7120.715171393138;5570.3315602127705;6989.615571143585;7001.334873187039;7069.787906362804;7089.078419805431;4892.608591312704;4990;5120.180771076629;5149.40781810091;5157.7936882524655;5124.128898087334;5163.845084647448;5179.870503237412;5181.6113791465605;5206.843794686166;5136.871578210537;5142.280080788692;5143.3570803649545;5156.432792392834;5164.457731938149;5145.742712864342;5148.897022059576;5159.993801208747;5162.406323272815;5180.818671346522;3679.558452985632;4337.002489427449;4410.647148228134;4415.51429342772;4422.159789639958;6653.489163064192;6678.332166783332;6817.659117044128;6823.624700641462;6888.483363747739;5965.940340596625;6040.456358927674;6050.69746512677;6051.818445446644;6070.119832624289;7562.886556701654;7566.054243219598;7587;7608.8478230435085;7613.42899282556;4991.251312303148;5003.024410240005;5010.423801262828;5012.924806127911;5015.974920125413;7800.336971357441;8044.557549334842;8095.069067057305;8105.432619716622;8136.877946830802;5054.660514963538;5109.20807274873;5118.181091025418;5123.666961647481;5124.5131712487255;5206.114960456732;5211.609129315317;5219.19102539107;5226.425093239741;5249.553787927993;6062.636241825505;6063.757449701962;6065.2418447694035;6065.4541091302;6081.179040829431;7633.69465221385;7655.043119610049;7658.8085297868;7661.808454788675;7674.232576742281;1752.807191208966;1793.3454289184615;1807.1777341309673;1823.8996855172827;1824.3888297420247;1152.0610702277618;1154.417019405195;1154.6593754842343;1162.7267592115845;1166.5392170092935;7181;7193.3166349196745;7216;7236.710531578678;7242.818929526698;6266.49868010558;6388.520860935449;7574.356179724785;7871;7874.212578742195;6536.908189379353;6668.699908504129;7238.855222895512;7255.201927787939;7322;4183.414321994923;4212.326027835532;4226.387173859773;4235.30117530604;4265.55211702773;8327.417080804407;8364.707235246737;8403.789905252417;8411.579421028924;8430.32557395407;7918.643661035152;8281.710140145187;8288.254057134887;8310.667573297122;8343.123971982854;8301.29438997692;8368.874466883002;8380.455270407405;8390.951131108734;8422.831543369099;7980.840383192188;7983.84032319362;7990.881276621394;8006.639701213576;8007.199280071946;7641;7747.496412733154;7875.291223789886;7890.881636775338;7892.605369731606;8332.250097491255;8333.458325208841;8353.122922093336;8354.913861198249;8377.246047855722;5120.871978200575;5122.436531981553;5125.384953805567;5133.512316329943;5135.614828887774;6050.334463209131;7952.36381089523;7962.124166341582;7972.521648701097;7993.760187194393;5495.340559132929;6961.37347638715;7282.198958114709;7697.499662521918;7724.266194711493;7676.501027433199;7685.538867667958;7703.961480192564;7710.306072453506;7733.7679869604;7503.474756766974;7528.360089392463;7546.698132074655;7550.169481357156;7565.508241964255;7657.540547567164;7658.69365225407;7672.846543068996;7675.53946763196;7704.152543220129;6980.53408784161;7228;7486.6256687166515;7548.320651141424;7579.090509138939 15:52:52 INFO - PROCESS | 2022 | |5;yui.html;540.6377726922964;590.3613862120454;690.1407747354544;721.5310048468494;773.3542492019162;15057.849421505782;15170.84829151711;15304.311305991228;15346.846531534682;15371.154586497738;14016.579502614937;14025.719485610281;14094.36575354109;14106.92946535266;14158.787618185735;781.0549235425142;792.9770595931242;939;953.7472569769017;976.9853452198187;946.6781294359917;948.7296120605629;948.8339540580405;953.3945944325369;957.8371676814924;1008.8991100889889;1018.0532105142215;1025.7486915705624;1029.696239609317;1032.6695457453618;977.7164622259536;1021.2748948246754;1023.5854478936043;1025.5590096258607;1026.3892983674702;747.8279995601042;761.375671949002;767.3860911271016;768.2547928509393;768.389130641136;11623.360715160663;14979.700405991927;14994.100353978796;15029.473968411054;15089.24553772307;13344.132631378929;13344.599662010156;13352.33238338089;13475.66310842227;13479.056466047381;8717;8868.733937981871;8924.687635932776;8982;8996.010438851721;3571.23218508022;3622.9094272643133;3659.5608526976666;3680.5031320771886;3868.3810590305416;78895.6055219726;81492.59253703753;81671.18328816695;82518.58740706259;82707.5864620679;9737.805243895224;9830;9943.204543636492;10034.899651003543;10186.490675466197;23140.65289020666;23239.7676023241;23251.418714531934;23276.65085023726;23324.883375583013;6210.72051757672;7235.2402997684485;7431.368333691588;7649.196834332426;7653.770386888402;3970.5830887756947;4243.830246790156;4256.106217694257;4304.647288460092;4304.80628371724;3659.0669379308106;3676.4117741161285;3696.9815150924073;3709.3323201823932;3711.703063754947;654.9410553050249;661.4179522020592;669.310610071627;678.5284227461866;680.5100327764002;555.2199160179954;573.7274794472676;625.9311475737666;629.5058379172327;645.0936434309803;8251.628676709563;8385.916140838513;8399.496030238082;8418.200270974248;8574;602;623.6195920488499;623.7255607532671;635.4948063371596;649.0556240669814;3924.6467817895955;3997.8001099944886;4008.997750562359;4012.3179059559943;4084.3465045593157;89634.55182724044;91543;91613;93030;94054.52972735092;76888;77944.61027694939;78330.6083469579;79194;82528.17471825205;73833;75295.49409011789;75609;76765;77295.61352193203;8706.651733930572;8875.866861996947;8917.821643567222;8922.464652120894;8941.46351218929;50629.49370506248;50850.74574627103;51933;53503.19745203903;54051;68854.65572672104;69445;69927;70328;72195;10832.891671083189;10936;11228.214025018171;11292.943535282271;11416.828747568627;12120.696982575506;12194.451249693962;12392.876071239532;12415.751684966432;12961.898238649443;11575.578704279857;11614.6515604532;11626.360550169484;11672.533098675958;11945.104117191071;11729.706757330794;11824.940875295568;11876.940615296868;11938.164328496921;12391.75216495683;10935.617253396093;11109.888901110886;11812;12015.038796896053;12260.693482663004;9711.5144242789;9773;9923.206143508358;9946.502674866373;10048.899511004796;9603.087706667855;9785.951070244602;9866.013398660076;9949.235538118293;9959.153471954674 15:52:52 INFO - PROCESS | 2022 | __end_tp_report 15:52:52 INFO - PROCESS | 2022 | __start_cc_report 15:52:52 INFO - PROCESS | 2022 | _x_x_mozilla_cycle_collect,406 15:52:52 INFO - PROCESS | 2022 | __end_cc_report 15:52:52 INFO - PROCESS | 2022 | __startTimestamp1467672772108__endTimestamp 15:52:52 INFO - PROCESS | 2022 | 15:52:52 INFO - PROCESS | 2022 | ------- Summary: start ------- 15:52:52 INFO - PROCESS | 2022 | Number of tests: 6 15:52:52 INFO - PROCESS | 2022 | 15:52:52 INFO - PROCESS | 2022 | [#0] dojo.html Cycles:165 Average:5807.89 Median:6110.76 stddev:698.60 (11.4%) stddev-sans-first:659.54 15:52:52 INFO - PROCESS | 2022 | Values: 2794.4 3608.5 3651.5 3668.2 3681.3 5869.2 5890.7 5901.6 5913.9 5966.8 5934.9 5955.3 5968.5 5994.0 6031.0 5248.4 5295.7 5360.1 5373.3 5413.5 4547.7 5275.5 5306.4 5363.6 5419.4 4370.8 5380.7 5399.2 5403.8 5449.8 5209.6 5341.3 5357.1 5365.5 5413.4 5188.7 5241.4 5276.2 5280.7 5331.2 4815.9 5260.8 5800.9 5803.7 5819.2 6153.2 6190.2 6253.8 6264.3 6289.6 5161.4 5641.7 6195.5 6325.1 6345.3 6015.8 6020.3 6027.5 6035.5 6045.8 5565.9 6212.4 6301.8 6449.6 6483.2 6219.6 6221.9 6233.2 6251.6 6257.6 6339.6 6353.9 6354.8 6384.8 6390.2 6125.2 6184.2 6221.1 6233.6 6266.2 5293.4 6199.8 6248.9 6249.3 6260.8 4994.1 4994.8 5043.8 5078.3 5089.8 3574.4 3857.5 3905.8 4474.1 4534.5 5936.0 5992.1 6103.1 6105.4 6134.3 5335.3 5857.3 6295.2 6307.3 6328.8 4889.8 6061.7 6112.7 6114.8 6128.5 5482.9 5506.7 5542.1 5542.9 5555.5 6365.5 6592.8 6597.7 6598.4 6612.7 5631.3 6250.8 6306.1 6311.3 6352.4 6529.5 6553.6 6584.3 6588.3 6604.8 6151.7 6187.8 6282.1 6285.4 6285.5 6259.4 6266.6 6321.1 6328.5 6342.4 6093.3 6199.5 6228.7 6230.5 6262.9 6130.3 6152.2 6210.7 6239.8 6254.4 6110.8 6138.3 6142.8 6172.9 6195.4 5731.8 6233.9 6245.8 6259.6 6276.5 6040.8 6102.5 6112.4 6119.1 6137.1 15:52:52 INFO - PROCESS | 2022 | 15:52:52 INFO - PROCESS | 2022 | [#1] ext.html Cycles:180 Average:65128.04 Median:38666.31 stddev:141134.81 (365.0%) stddev-sans-first:141447.36 15:52:52 INFO - PROCESS | 2022 | Values: 516.7 517.8 527.6 530.4 677.8 39176.8 40282.6 40324.0 40419.8 40472.0 41510.8 41709.2 42258.6 42279.2 42368.4 9581.9 9786.0 9835.8 9836.0 9853.2 9634.4 9858.1 9883.6 9932.4 9968.7 9878.7 9903.1 9921.4 9923.4 9927.9 9820.7 9847.5 9878.9 9898.9 9918.9 9816.9 9865.2 9902.3 9943.2 9956.3 33626.3 40245.6 40397.4 40523.2 40635.8 2961.4 3220.4 3284.6 3325.2 3425.2 30214.4 30286.7 30325.0 31166.1 31167.7 2776.1 2836.1 2840.0 2942.8 2968.3 378323.0 379132.0 384452.0 385605.0 387534.0 39199.0 68320.7 68750.0 69585.7 73571.6 34118.1 38600.0 38917.8 39292.0 39292.6 16689.9 16801.5 16903.7 16938.2 17208.7 14156.9 14308.7 14312.0 14332.3 14342.2 8432.8 8484.7 8606.3 8926.2 8941.9 3704.7 3724.1 3729.9 3730.5 3732.7 1013.1 1022.3 1036.3 1164.6 1166.9 30690.5 30830.0 31277.8 31469.5 31526.5 1130.1 1130.7 1139.5 1173.1 1241.1 13210.8 14624.9 14894.0 15078.2 15400.8 557230.0 615683.0 619543.0 625492.0 627933.0 56974.7 57551.7 58202.7 59000.7 59133.1 1579.9 1597.8 1601.3 1608.5 1677.5 29416.9 29590.4 29683.7 30131.4 30211.2 44567.6 52517.7 52813.7 53708.0 53869.0 559457.0 563844.2 563886.0 564749.0 565479.0 24362.5 26984.0 28042.9 28201.3 28483.7 45504.5 46401.1 46639.8 47642.3 47808.3 36860.9 38732.6 38744.4 39362.8 39504.4 37941.9 37951.2 37969.0 38804.8 38818.6 32761.8 37531.6 37886.8 38274.6 38506.0 28220.5 35229.6 35313.5 35325.8 35367.8 20453.3 25507.1 25520.9 25591.4 25826.2 15:52:52 INFO - PROCESS | 2022 | 15:52:52 INFO - PROCESS | 2022 | [#2] jquery.html Cycles:180 Average:36401.51 Median:13657.93 stddev:107604.25 (787.9%) stddev-sans-first:107872.11 15:52:52 INFO - PROCESS | 2022 | Values: 374.2 409.5 414.0 416.2 427.5 16131.8 20737.7 21436.6 21448.4 21698.0 20645.7 21144.8 21199.0 21536.4 21561.2 5665.9 5776.5 5836.4 5961.4 5980.2 5715.4 5856.0 5891.2 6010.8 6038.9 4952.3 5989.6 6005.7 6034.6 6037.5 5760.8 5784.2 5867.7 5881.9 5904.5 4655.5 5577.1 5969.2 5997.1 6016.0 20971.9 23608.8 24932.6 24942.4 26215.7 2248.1 2333.1 2383.2 2589.9 2631.6 9937.4 10368.8 10757.6 11592.5 15000.6 1691.9 1734.4 1761.4 1805.2 1840.2 113077.4 113708.0 114833.4 115663.3 120251.0 10445.5 11473.5 11686.0 11740.6 12189.6 15127.5 15207.5 15279.9 15301.4 15347.5 8713.0 9063.6 9162.3 9166.0 9243.4 7692.9 9283.8 9329.3 9338.0 9344.7 4674.8 4728.4 4774.6 4793.0 4847.2 2003.4 2044.4 2046.8 2066.3 2068.9 919.6 945.7 966.8 1001.4 1094.4 18121.5 20020.5 20249.4 20252.4 20811.5 909.9 930.3 932.6 1070.0 1075.1 8999.4 10982.8 11001.3 11024.6 11052.9 591494.0 645682.0 662682.0 663424.0 665660.0 116168.0 136588.6 138865.0 139452.0 141701.0 1044.5 1112.4 1117.5 1119.5 1125.1 15269.6 17630.8 18401.8 18564.1 18598.0 48820.3 51129.2 52651.5 54440.2 55360.0 74638.0 79380.8 79661.6 79836.4 81074.0 6986.6 7788.4 8006.0 8061.7 8078.6 8991.8 11570.8 12197.8 12380.8 12409.9 9736.6 9980.4 10840.2 11012.6 11162.1 10427.5 10557.4 10570.2 10816.2 10860.6 10259.5 10898.8 11155.2 11174.3 11277.7 8084.1 8106.7 8139.8 8179.8 8296.3 8083.1 9442.9 9958.7 10871.5 11042.5 15:52:52 INFO - PROCESS | 2022 | 15:52:52 INFO - PROCESS | 2022 | [#3] mootools.html Cycles:180 Average:5845.96 Median:5075.12 stddev:3184.52 (62.7%) stddev-sans-first:3176.57 15:52:52 INFO - PROCESS | 2022 | Values: 1483.2 1662.8 1885.2 1989.6 2026.1 7389.3 8037.6 9043.6 9128.4 9259.5 8858.8 8866.0 8955.9 8967.3 8998.9 2530.4 2531.1 2561.6 2565.9 2567.6 2523.1 2542.3 2575.3 2582.0 2584.1 2533.5 2559.8 2561.8 2564.9 2572.7 2382.0 2483.7 2536.8 2570.9 2594.3 2544.7 2577.8 2595.3 2596.2 2612.0 9117.8 9135.0 9160.7 9175.9 9223.1 5609.3 5714.2 5763.1 5769.4 5772.6 3670.2 3730.8 3743.0 3743.3 3856.2 1056.3 1067.9 1070.9 1079.2 1084.6 10578.8 11945.9 12109.6 12153.7 12386.3 4882.3 4895.2 5046.2 5053.0 5147.6 10460.0 10517.2 10554.5 10564.5 10566.4 5609.6 5611.9 5665.3 5743.5 5805.5 4596.5 5027.6 5126.5 5145.4 5177.9 4263.0 4325.7 4340.2 4367.1 4376.4 1405.0 1435.9 1440.8 1446.2 1461.4 822.3 914.7 915.3 929.5 972.5 5928.5 6029.5 6046.1 6071.6 6201.0 940.0 956.4 980.5 1012.8 1040.9 3571.7 3974.0 4040.8 4134.3 4160.7 10808.9 10814.0 10828.3 10899.2 10938.2 10853.3 10906.9 11062.4 11090.0 11127.7 7361.9 7490.7 8178.4 8206.3 8345.0 5603.7 5664.8 5731.0 5731.6 5935.5 9256.4 9399.3 9428.4 9480.1 9842.1 9518.3 9649.0 9786.1 9891.7 9898.2 7608.5 7707.4 7752.1 7838.5 7906.3 8340.7 8371.6 8481.4 8514.9 8567.6 7399.6 7558.2 7584.6 7631.4 7981.2 7057.1 7136.3 7285.3 7385.2 7550.7 6930.0 7090.5 7119.6 7128.4 7185.1 4883.2 4901.6 5012.8 5035.5 5053.2 4330.8 5010.0 5048.0 5097.0 5239.6 15:52:52 INFO - PROCESS | 2022 | 15:52:52 INFO - PROCESS | 2022 | [#4] prototype.html Cycles:180 Average:6225.14 Median:6995.48 stddev:2006.20 (28.7%) stddev-sans-first:1962.57 15:52:52 INFO - PROCESS | 2022 | Values: 338.5 339.8 342.6 345.4 352.4 6537.7 7028.4 7068.5 7081.0 7120.7 5570.3 6989.6 7001.3 7069.8 7089.1 4892.6 4990.0 5120.2 5149.4 5157.8 5124.1 5163.8 5179.9 5181.6 5206.8 5136.9 5142.3 5143.4 5156.4 5164.5 5145.7 5148.9 5160.0 5162.4 5180.8 3679.6 4337.0 4410.6 4415.5 4422.2 6653.5 6678.3 6817.7 6823.6 6888.5 5965.9 6040.5 6050.7 6051.8 6070.1 7562.9 7566.1 7587.0 7608.8 7613.4 4991.3 5003.0 5010.4 5012.9 5016.0 7800.3 8044.6 8095.1 8105.4 8136.9 5054.7 5109.2 5118.2 5123.7 5124.5 5206.1 5211.6 5219.2 5226.4 5249.6 6062.6 6063.8 6065.2 6065.5 6081.2 7633.7 7655.0 7658.8 7661.8 7674.2 1752.8 1793.3 1807.2 1823.9 1824.4 1152.1 1154.4 1154.7 1162.7 1166.5 7181.0 7193.3 7216.0 7236.7 7242.8 6266.5 6388.5 7574.4 7871.0 7874.2 6536.9 6668.7 7238.9 7255.2 7322.0 4183.4 4212.3 4226.4 4235.3 4265.6 8327.4 8364.7 8403.8 8411.6 8430.3 7918.6 8281.7 8288.3 8310.7 8343.1 8301.3 8368.9 8380.5 8391.0 8422.8 7980.8 7983.8 7990.9 8006.6 8007.2 7641.0 7747.5 7875.3 7890.9 7892.6 8332.3 8333.5 8353.1 8354.9 8377.2 5120.9 5122.4 5125.4 5133.5 5135.6 6050.3 7952.4 7962.1 7972.5 7993.8 5495.3 6961.4 7282.2 7697.5 7724.3 7676.5 7685.5 7704.0 7710.3 7733.8 7503.5 7528.4 7546.7 7550.2 7565.5 7657.5 7658.7 7672.8 7675.5 7704.2 6980.5 7228.0 7486.6 7548.3 7579.1 15:52:52 INFO - PROCESS | 2022 | 15:52:52 INFO - PROCESS | 2022 | [#5] yui.html Cycles:180 Average:18764.63 Median:596.18 stddev:26291.52 (4410.0%) stddev-sans-first:26329.66 15:52:52 INFO - PROCESS | 2022 | Values: 540.6 590.4 690.1 721.5 773.4 15057.8 15170.8 15304.3 15346.8 15371.2 14016.6 14025.7 14094.4 14106.9 14158.8 781.1 793.0 939.0 953.7 977.0 946.7 948.7 948.8 953.4 957.8 1008.9 1018.1 1025.7 1029.7 1032.7 977.7 1021.3 1023.6 1025.6 1026.4 747.8 761.4 767.4 768.3 768.4 11623.4 14979.7 14994.1 15029.5 15089.2 13344.1 13344.6 13352.3 13475.7 13479.1 8717.0 8868.7 8924.7 8982.0 8996.0 3571.2 3622.9 3659.6 3680.5 3868.4 78895.6 81492.6 81671.2 82518.6 82707.6 9737.8 9830.0 9943.2 10034.9 10186.5 23140.7 23239.8 23251.4 23276.7 23324.9 6210.7 7235.2 7431.4 7649.2 7653.8 3970.6 4243.8 4256.1 4304.6 4304.8 3659.1 3676.4 3697.0 3709.3 3711.7 654.9 661.4 669.3 678.5 680.5 555.2 573.7 625.9 629.5 645.1 8251.6 8385.9 8399.5 8418.2 8574.0 602.0 623.6 623.7 635.5 649.1 3924.6 3997.8 4009.0 4012.3 4084.3 89634.6 91543.0 91613.0 93030.0 94054.5 76888.0 77944.6 78330.6 79194.0 82528.2 73833.0 75295.5 75609.0 76765.0 77295.6 8706.7 8875.9 8917.8 8922.5 8941.5 50629.5 50850.7 51933.0 53503.2 54051.0 68854.7 69445.0 69927.0 70328.0 72195.0 10832.9 10936.0 11228.2 11292.9 11416.8 12120.7 12194.5 12392.9 12415.8 12961.9 11575.6 11614.7 11626.4 11672.5 11945.1 11729.7 11824.9 11876.9 11938.2 12391.8 10935.6 11109.9 11812.0 12015.0 12260.7 9711.5 9773.0 9923.2 9946.5 10048.9 9603.1 9786.0 9866.0 9949.2 9959.2 15:52:52 INFO - PROCESS | 2022 | -------- Summary: end -------- 15:52:52 INFO - PROCESS | 2022 | 15:52:52 INFO - TEST-INFO | 2022: exit 0 15:52:52 INFO - TEST-OK | dromaeo_css | took 1108997ms 15:52:52 INFO - TEST-START | kraken 15:52:52 INFO - operating with platform_type : mac_ 15:52:52 INFO - Initialising browser for kraken test... 15:52:52 INFO - TEST-INFO | started process 2029 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpZ3KrKm/profile http://localhost:49399/getInfo.html) 15:52:55 INFO - PROCESS | 2029 | __metrics Screen width/height:1600/1200 15:52:55 INFO - PROCESS | 2029 | colorDepth:24 15:52:55 INFO - PROCESS | 2029 | Browser inner width/height: 1024/689 15:52:55 INFO - PROCESS | 2029 | __metrics 15:52:55 ERROR - PROCESS | 2029 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 15:52:55 INFO - TEST-INFO | 2029: exit 0 15:52:55 INFO - Browser initialized. 15:52:55 INFO - Running cycle 1/1 for kraken test... 15:52:55 INFO - TEST-INFO | started process 2033 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpZ3KrKm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:07 INFO - PROCESS | 2033 | RSS: Main: 171241472 15:53:07 INFO - PROCESS | 2033 | 15:53:10 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49399/tests/kraken/driver.html?testName=audio-beat-detection) 15:53:11 INFO - PROCESS | 2033 | RSS: Main: 183889920 15:53:11 INFO - PROCESS | 2033 | 15:53:14 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49399/tests/kraken/driver.html?testName=audio-dft) 15:53:14 INFO - PROCESS | 2033 | RSS: Main: 192876544 15:53:14 INFO - PROCESS | 2033 | 15:53:18 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49399/tests/kraken/driver.html?testName=audio-fft) 15:53:18 INFO - PROCESS | 2033 | RSS: Main: 196591616 15:53:18 INFO - PROCESS | 2033 | 15:53:20 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49399/tests/kraken/driver.html?testName=audio-oscillator) 15:53:21 INFO - PROCESS | 2033 | RSS: Main: 197496832 15:53:21 INFO - PROCESS | 2033 | 15:53:23 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49399/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:53:24 INFO - PROCESS | 2033 | RSS: Main: 198402048 15:53:24 INFO - PROCESS | 2033 | 15:53:26 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49399/tests/kraken/driver.html?testName=imaging-darkroom) 15:53:27 INFO - PROCESS | 2033 | RSS: Main: 198639616 15:53:27 INFO - PROCESS | 2033 | 15:53:30 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49399/tests/kraken/driver.html?testName=imaging-desaturate) 15:53:31 INFO - PROCESS | 2033 | RSS: Main: 198914048 15:53:31 INFO - PROCESS | 2033 | 15:53:33 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49399/tests/kraken/driver.html?testName=json-parse-financial) 15:53:34 INFO - PROCESS | 2033 | RSS: Main: 199344128 15:53:34 INFO - PROCESS | 2033 | 15:53:36 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49399/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:53:36 INFO - PROCESS | 2033 | RSS: Main: 197861376 15:53:36 INFO - PROCESS | 2033 | 15:53:38 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49399/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:53:39 INFO - PROCESS | 2033 | RSS: Main: 198533120 15:53:39 INFO - PROCESS | 2033 | 15:53:41 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49399/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:42 INFO - PROCESS | 2033 | RSS: Main: 198819840 15:53:42 INFO - PROCESS | 2033 | 15:53:44 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:45 INFO - PROCESS | 2033 | RSS: Main: 198434816 15:53:45 INFO - PROCESS | 2033 | 15:53:48 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:53:48 INFO - PROCESS | 2033 | RSS: Main: 198254592 15:53:48 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:49399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49399/tests/kraken/driver.html?testName=ai-astar) 15:53:50 INFO - PROCESS | 2033 | RSS: Main: 200048640 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | __start_tp_report 15:53:50 INFO - PROCESS | 2033 | _x_x_mozilla_page_load 15:53:50 INFO - PROCESS | 2033 | _x_x_mozilla_page_load_details 15:53:50 INFO - PROCESS | 2033 | |i|pagename|runs| 15:53:50 INFO - PROCESS | 2033 | |0;ai-astar;126;169;111;129;173;164;107;116;116;115 15:53:50 INFO - PROCESS | 2033 | |1;audio-beat-detection;154;154;143;155;122;143;125;170;146;143 15:53:50 INFO - PROCESS | 2033 | |2;audio-dft;194;234;195;195;194;194;194;196;227;283 15:53:50 INFO - PROCESS | 2033 | |3;audio-fft;62;71;82;142;57;57;56;67;126;58 15:53:50 INFO - PROCESS | 2033 | |4;audio-oscillator;79;88;117;75;115;126;164;77;68;162 15:53:50 INFO - PROCESS | 2033 | |5;imaging-gaussian-blur;124;86;108;131;115;86;90;85;87;87 15:53:50 INFO - PROCESS | 2033 | |6;imaging-darkroom;94;96;97;138;94;109;95;94;94;94 15:53:50 INFO - PROCESS | 2033 | |7;imaging-desaturate;90;91;98;93;90;118;142;94;89;91 15:53:50 INFO - PROCESS | 2033 | |8;json-parse-financial;58;62;65;65;65;66;66;79;60;58 15:53:50 INFO - PROCESS | 2033 | |9;json-stringify-tinderbox;65;84;107;105;74;76;59;62;77;93 15:53:50 INFO - PROCESS | 2033 | |10;stanford-crypto-aes;81;80;83;82;83;82;80;80;104;87 15:53:50 INFO - PROCESS | 2033 | |11;stanford-crypto-ccm;135;122;148;146;143;145;157;153;168;165 15:53:50 INFO - PROCESS | 2033 | |12;stanford-crypto-pbkdf2;166;159;161;164;164;159;162;165;163;162 15:53:50 INFO - PROCESS | 2033 | |13;stanford-crypto-sha256-iterative;65;67;68;71;65;63;69;66;69;81 15:53:50 INFO - PROCESS | 2033 | __end_tp_report 15:53:50 INFO - PROCESS | 2033 | __start_cc_report 15:53:50 INFO - PROCESS | 2033 | _x_x_mozilla_cycle_collect,1035 15:53:50 INFO - PROCESS | 2033 | __end_cc_report 15:53:50 INFO - PROCESS | 2033 | __startTimestamp1467672830808__endTimestamp 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | ------- Summary: start ------- 15:53:50 INFO - PROCESS | 2033 | Number of tests: 14 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#0] ai-astar Cycles:10 Average:132.60 Median:127.50 stddev:25.78 (20.2%) stddev-sans-first:27.24 15:53:50 INFO - PROCESS | 2033 | Values: 126.0 169.0 111.0 129.0 173.0 164.0 107.0 116.0 116.0 115.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:150.00 stddev:14.25 (9.5%) stddev-sans-first:14.77 15:53:50 INFO - PROCESS | 2033 | Values: 154.0 154.0 143.0 155.0 122.0 143.0 125.0 170.0 146.0 143.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#2] audio-dft Cycles:10 Average:210.60 Median:195.50 stddev:29.55 (15.1%) stddev-sans-first:30.73 15:53:50 INFO - PROCESS | 2033 | Values: 194.0 234.0 195.0 195.0 194.0 194.0 194.0 196.0 227.0 283.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#3] audio-fft Cycles:10 Average:77.80 Median:60.00 stddev:30.93 (51.5%) stddev-sans-first:32.27 15:53:50 INFO - PROCESS | 2033 | Values: 62.0 71.0 82.0 142.0 57.0 57.0 56.0 67.0 126.0 58.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:71.50 stddev:35.57 (49.8%) stddev-sans-first:36.25 15:53:50 INFO - PROCESS | 2033 | Values: 79.0 88.0 117.0 75.0 115.0 126.0 164.0 77.0 68.0 162.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#5] imaging-gaussian-blur Cycles:10 Average:99.90 Median:86.00 stddev:17.89 (20.8%) stddev-sans-first:16.72 15:53:50 INFO - PROCESS | 2033 | Values: 124.0 86.0 108.0 131.0 115.0 86.0 90.0 85.0 87.0 87.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:94.00 stddev:13.95 (14.8%) stddev-sans-first:14.60 15:53:50 INFO - PROCESS | 2033 | Values: 94.0 96.0 97.0 138.0 94.0 109.0 95.0 94.0 94.0 94.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#7] imaging-desaturate Cycles:10 Average:99.60 Median:91.00 stddev:17.19 (18.9%) stddev-sans-first:17.87 15:53:50 INFO - PROCESS | 2033 | Values: 90.0 91.0 98.0 93.0 90.0 118.0 142.0 94.0 89.0 91.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:6.02 (9.3%) stddev-sans-first:5.93 15:53:50 INFO - PROCESS | 2033 | Values: 58.0 62.0 65.0 65.0 65.0 66.0 66.0 79.0 60.0 58.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#9] json-stringify-tinderbox Cycles:10 Average:80.20 Median:75.00 stddev:16.96 (22.6%) stddev-sans-first:17.08 15:53:50 INFO - PROCESS | 2033 | Values: 65.0 84.0 107.0 105.0 74.0 76.0 59.0 62.0 77.0 93.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:82.00 stddev:7.27 (8.9%) stddev-sans-first:7.62 15:53:50 INFO - PROCESS | 2033 | Values: 81.0 80.0 83.0 82.0 83.0 82.0 80.0 80.0 104.0 87.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:150.50 stddev:13.65 (9.1%) stddev-sans-first:13.62 15:53:50 INFO - PROCESS | 2033 | Values: 135.0 122.0 148.0 146.0 143.0 145.0 157.0 153.0 168.0 165.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.50 stddev:2.37 (1.4%) stddev-sans-first:2.15 15:53:50 INFO - PROCESS | 2033 | Values: 166.0 159.0 161.0 164.0 164.0 159.0 162.0 165.0 163.0 162.0 15:53:50 INFO - PROCESS | 2033 | 15:53:50 INFO - PROCESS | 2033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:5.02 (7.3%) stddev-sans-first:5.17 15:53:50 INFO - PROCESS | 2033 | Values: 65.0 67.0 68.0 71.0 65.0 63.0 69.0 66.0 69.0 81.0 15:53:50 INFO - PROCESS | 2033 | -------- Summary: end -------- 15:53:50 INFO - PROCESS | 2033 | 15:53:51 INFO - TEST-INFO | 2033: exit 0 15:53:51 INFO - TEST-OK | kraken | took 58935ms 15:53:51 INFO - SUITE-END | took 1167s 15:53:51 INFO - Completed test suite (00:19:28) 15:53:51 INFO - javascript benchmark 15:53:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2794.4411117776444, 3608.5489313835756, 3651.47053677217, 3668.1563240454693, 3681.3189559931416, 5869.178315035899, 5890.676012819294, 5901.616394934326, 5913.852153696154, 5966.761329546818, 5934.88130237395, 5955.2853657561045, 5968.522518198544, 5993.970030149843, 6030.969845150779, 5248.370195576526, 5295.655782374152, 5360.061989151883, 5373.274607927919, 5413.458654134574, 4547.726636541774, 5275.498827611371, 5306.389765176996, 5363.6245462817615, 5419.430959749228, 4370.781460926957, 5380.7309634518315, 5399.19012148177, 5403.8108666196695, 5449.809256676017, 5209.583233341362, 5341.278927344836, 5357.142857142878, 5365.543928766059, 5413.377461591908, 5188.662736922088, 5241.449647786965, 5276.155815069609, 5280.683159010433, 5331.2003199519995, 4815.940493091514, 5260.763265653055, 5800.941990580082, 5803.651780893118, 5819.24349834523, 6153.230846144232, 6190.195274614316, 6253.843653908643, 6264.3422440643535, 6289.559730818844, 5161.380634323905, 5641.717914104278, 6195.513076861565, 6325.0828629848875, 6345.302016778151, 6015.789447369321, 6020.2775666919815, 6027.457528822383, 6035.517158627387, 6045.788397406113, 5565.888682226414, 6212.409821067082, 6301.842453938597, 6449.645269510128, 6483.1847082816885, 6219.595726277777, 6221.9377806221355, 6233.2208473940755, 6251.624902505864, 6257.56197066201, 6339.587926784837, 6353.8729225416155, 6354.8411289717205, 6384.840378990562, 6390.169277993831, 6125.20492926512, 6184.165137706352, 6221.097940798559, 6233.594816336924, 6266.248050234001, 5293.391260005149, 6199.752009919553, 6248.875022499525, 6249.25008998923, 6260.812175634647, 4994.051130285234, 4994.775235114428, 5043.798248070036, 5078.289039534468, 5089.796408143633, 3574.428091505347, 3857.517810273716, 3905.7851818149707, 4474.127545128734, 4534.546545345439, 5936.0, 5992.0712289595185, 6103.084537319438, 6105.421132926843, 6134.283518479771, 5335.279737235501, 5857.26784151981, 6295.194803903069, 6307.306196318401, 6328.778492752732, 4889.779959901813, 6061.727222275008, 6112.663803490851, 6114.785982490592, 6128.509719222451, 5482.890342193134, 5506.669599824023, 5542.057850165482, 5542.91685624716, 5555.472230138131, 6365.52258580599, 6592.76925307612, 6597.670116494156, 6598.406143447113, 6612.735490580323, 5631.267935168402, 6250.781222657185, 6306.148669929501, 6311.274203466476, 6352.36476352361, 6529.542931994714, 6553.639549824806, 6584.308647591934, 6588.308227636221, 6604.778116048355, 6151.72317245716, 6187.81436556904, 6282.089097080806, 6285.43431091204, 6285.465735412358, 6259.374062593704, 6266.592671476339, 6321.051842223703, 6328.46208072319, 6342.429181373698, 6093.329733729375, 6199.473044791243, 6228.688565571794, 6230.470410015199, 6262.937370626418, 6130.306415576139, 6152.200213972155, 6210.689465526615, 6239.78160764371, 6254.3745625437095, 6110.7555697771595, 6138.324784273816, 6142.815715528542, 6172.938270617236, 6195.380461953949, 5731.799387021434, 6233.937660623335, 6245.7813976512425, 6259.561830671809, 6276.466500347522, 6040.788572399945, 6102.511799055976, 6112.419320164578, 6119.051547010221, 6137.140800288053], "value": 5763.369080480346, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.6951498615816, 517.800646751001, 527.6148411659489, 530.4350866327361, 677.8271540757106, 39176.82469525915, 40282.59717402829, 40324.0, 40419.79790101053, 40471.98820029501, 41510.792446037725, 41709.16581668365, 42258.577414225845, 42279.154416911646, 42368.36447453291, 9581.90418095817, 9786.021397860228, 9835.803283934318, 9835.95082024589, 9853.211743060538, 9634.421934683907, 9858.063483969012, 9883.55524001418, 9932.354396964174, 9968.6510972116, 9878.703638890845, 9903.059209375135, 9921.40471571708, 9923.40459572428, 9927.900720992806, 9820.65627703034, 9847.507624618776, 9878.851817222747, 9898.851517227247, 9918.851217231748, 9816.901830981671, 9865.210783137332, 9902.306838521306, 9943.204543636564, 9956.303058785888, 33626.32747345064, 40245.59754402448, 40397.394039089144, 40523.18953620941, 40635.796821015705, 2961.363306889029, 3220.4203243416177, 3284.6222684391364, 3325.185329594265, 3425.2293234022395, 30214.395712085636, 30286.697133028607, 30325.0, 31166.065018049496, 31167.688323116705, 2776.083892315531, 2836.092450415868, 2839.9858000709864, 2942.7792915531422, 2968.3469636679897, 378323.0, 379132.0, 384452.0, 385605.0, 387534.0, 39199.020024499616, 68320.6583967077, 68750.0, 69585.65207174033, 73571.63214183894, 34118.147046323546, 38600.0, 38917.80541097277, 39292.0, 39292.60707392889, 16689.91655041717, 16801.495955121365, 16903.661926761397, 16938.153092345332, 17208.741868871977, 14156.85843141576, 14308.713825723635, 14312.0, 14332.283385830875, 14342.211178385289, 8432.831343373098, 8484.745457636282, 8606.31149508038, 8926.196642302224, 8941.865872011926, 3704.7406681532034, 3724.1062145084984, 3729.850805967785, 3730.515033045687, 3732.664060234592, 1013.108464551205, 1022.2690776095128, 1036.2797855490512, 1164.644783341072, 1166.9066474682006, 30690.53964190539, 30830.0, 31277.8436107818, 31469.527957080663, 31526.527102093485, 1130.1015692524463, 1130.7455822439886, 1139.5384869128015, 1173.096715529038, 1241.1436109084702, 13210.801837972438, 14624.85375146235, 14893.957263077817, 15078.170700611572, 15400.845991539942, 557230.0, 615683.0, 619543.0, 625492.0, 627933.0, 56974.715126424104, 57551.71224143852, 58202.708986454796, 59000.70499647474, 59133.113003304985, 1579.88940774147, 1597.7523483859788, 1601.3434491858281, 1608.4933246027465, 1677.547062293174, 29416.852915735286, 29590.40819183647, 29683.703162968093, 30131.397372051997, 30211.244718882204, 44567.55432445764, 52517.7374113127, 52813.735931320094, 53708.0, 53869.0, 559457.0, 563844.1807790935, 563886.0, 564749.0, 565479.0, 24362.51274974455, 26984.0, 28042.85978570094, 28201.294967625974, 28483.715162848108, 45504.54495455003, 46401.07197856092, 46639.83400414881, 47642.285365720236, 47808.282875756195, 36860.89417317485, 38732.6126738729, 38744.41883371808, 39362.80318598389, 39504.407433887936, 37941.86174414772, 37951.24097517979, 37969.0, 38804.80597597107, 38818.6118138815, 32761.836190819846, 37531.624683752816, 37886.810565946995, 38274.61725382822, 38506.0373490665, 28220.457127548147, 35229.64770352366, 35313.47029794606, 35325.82337088298, 35367.78242886584, 20453.2841350552, 25507.107251246118, 25520.872395637904, 25591.360215994006, 25826.225213243633], "value": 19040.091526562373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.24215962675584, 409.4533797380497, 413.9958600413995, 416.2465936654654, 427.51904107878636, 16131.758023629654, 20737.688934665974, 21436.57126857464, 21448.356549303528, 21698.023588938497, 20645.690314645293, 21144.788552114474, 21199.04604292807, 21536.353909382706, 21561.245356412528, 5665.943340566593, 5776.451237132465, 5836.358000619928, 5961.374055724152, 5980.222571065756, 5715.428457154293, 5855.970720146393, 5891.234139561872, 6010.789622363218, 6038.909416358758, 4952.281919121743, 5989.550783691218, 6005.669688167149, 6034.577579569432, 6037.516998640098, 5760.7695692172265, 5784.219130417403, 5867.70661466925, 5881.85295367615, 5904.5276377890095, 4655.4878963314, 5577.061217974301, 5969.224000879901, 5997.070454079625, 6016.007358785839, 20971.895140524353, 23608.763912360828, 24932.626010609856, 24942.37644058895, 26215.737842621522, 2248.1119957616816, 2333.0667732906973, 2383.2254517281954, 2589.935251618706, 2631.644727961739, 9937.354071985297, 10368.792624147474, 10757.62348317813, 11592.536298548048, 15000.624984375369, 1691.9407820726215, 1734.3929624631278, 1761.445144779403, 1805.2147315917618, 1840.2271046160645, 113077.43461282642, 113708.0, 114833.42583287113, 115663.2650510243, 120251.0, 10445.477726113664, 11473.483693233824, 11686.0, 11740.647780566596, 12189.634310970685, 15127.54617361481, 15207.543773686586, 15279.930404871775, 15301.387944482318, 15347.462838800588, 8713.0, 9063.637454501877, 9162.312826537904, 9166.0, 9243.445393276425, 7692.884606730903, 9283.767905802273, 9329.253659707207, 9338.0, 9344.719658410258, 4674.813007479731, 4728.385309909759, 4774.570288674036, 4793.01743142655, 4847.224444088929, 2003.3789525246927, 2044.396902913644, 2046.8464865134877, 2066.3077868914083, 2068.917243310281, 919.6137622198693, 945.6784693204344, 966.79213968997, 1001.4041645221082, 1094.4240293976648, 18121.54696132581, 20020.49948751293, 20249.39251822448, 20252.392428227176, 20811.479713007295, 909.8953620333614, 930.297625292913, 932.5989824375583, 1070.03162138265, 1075.0808059109506, 8999.37004409685, 10982.780344393228, 11001.339919604688, 11024.559017639365, 11052.889471105185, 591494.0, 645682.0, 662682.0, 663424.0, 665660.0, 116168.0, 136588.63411365758, 138865.0, 139452.0, 141701.0, 1044.4882007816116, 1112.4326593437243, 1117.463617463622, 1119.513011839836, 1125.1224045244721, 15269.6182595436, 17630.82369176292, 18401.815981840547, 18564.071796409855, 18598.0, 48820.26769598388, 51129.2104776331, 52651.47348526466, 54440.18339724828, 55360.0, 74638.0, 79380.80928785958, 79661.60169199349, 79836.40327193307, 81074.0, 6986.615736134561, 7788.376929845485, 8005.9599702001115, 8061.677532898853, 8078.555679437687, 8991.831061961902, 11570.826437603611, 12197.817032744339, 12380.752384952071, 12409.875901241234, 9736.561854716412, 9980.351277166961, 10840.186985975926, 11012.614558490735, 11162.051225645911, 10427.478626068818, 10557.366558006544, 10570.154387648816, 10816.188785840935, 10860.619878304222, 10259.487025648838, 10898.836517452086, 11155.219134660496, 11174.27367221128, 11277.71805704864, 8084.070331911906, 8106.657122404948, 8139.79650508742, 8179.754607361789, 8296.294814940798, 8083.070446898682, 9442.905570944478, 9958.701238962843, 10871.510782014986, 11042.503087360927], "value": 9660.096597683341, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.1546018769302, 1662.8004639443266, 1885.1893685715145, 1989.621971825353, 2026.0680087159906, 7389.298016688419, 8037.5579343136105, 9043.593038313275, 9128.361014728971, 9259.490728009956, 8858.822823543525, 8865.95567022164, 8955.86566201506, 8967.327450441211, 8998.910010899888, 2530.430653103051, 2531.1267612673596, 2561.602951542505, 2565.8973641054336, 2567.550678631241, 2523.0916869926814, 2542.2627438043037, 2575.3432874616947, 2582.0, 2584.1084825735184, 2533.505966336565, 2559.7696207341337, 2561.782248508879, 2564.948701025978, 2572.7298633643477, 2382.0, 2483.7392073832257, 2536.7970562355154, 2570.9228723138335, 2594.286571192918, 2544.6691930048974, 2577.8453292802305, 2595.299269197325, 2596.1692258477296, 2612.0, 9117.81764364709, 9135.040820713795, 9160.725178244664, 9175.908240917572, 9223.07769223079, 5609.326880774333, 5714.200011998323, 5763.106718458645, 5769.423057694239, 5772.595918285721, 3670.229251857113, 3730.776153430803, 3742.9812850935573, 3743.2513497300647, 3856.1709232515145, 1056.313396292416, 1067.8520590365388, 1070.882202957674, 1079.1528650009705, 1084.5932775209296, 10578.788424231472, 11945.880541194563, 12109.576164834276, 12153.69615759613, 12386.256824590553, 4882.316475693406, 4895.192293271642, 5046.167382381939, 5052.9747351263, 5147.562457191106, 10459.95400459948, 10517.211209159344, 10554.525046372932, 10564.524596393027, 10566.366018038942, 5609.635373700697, 5611.915821262684, 5665.3201615806365, 5743.483086522149, 5805.506531944832, 4596.49438561758, 5027.572656324181, 5126.512981266774, 5145.3568303962, 5177.922331165036, 4262.957370426256, 4325.6755743318745, 4340.2187606230555, 4367.148406060851, 4376.387305777193, 1404.9789253161211, 1435.9497417590335, 1440.8343040550471, 1446.24795106544, 1461.4154338264566, 822.3051521464353, 914.6752902719438, 915.2540679346445, 929.4887811703671, 972.4797233480055, 5928.4960778334325, 6029.468302352123, 6046.102656847967, 6071.605345652607, 6201.0, 939.9624015039459, 956.4357029352715, 980.5048450532436, 1012.8176928153003, 1040.8594839696696, 3571.714262859017, 3973.960260397359, 4040.8383664653084, 4134.276501612206, 4160.667146628262, 10808.919108089285, 10814.0, 10828.296160749525, 10899.237053406345, 10938.179636527293, 10853.294535855144, 10906.945465272624, 11062.446877656084, 11090.0, 11127.666170014912, 7361.889571656429, 7490.689129402442, 8178.427510074238, 8206.343492520704, 8345.040320363114, 5603.691796951207, 5664.801731939362, 5731.0, 5731.627444216113, 5935.495482884004, 9256.444613322952, 9399.295052870926, 9428.434293942386, 9480.146786788946, 9842.11420972116, 9518.286128540249, 9648.98685638026, 9786.070323319273, 9891.703248902544, 9898.158656514277, 7608.467407281659, 7707.421943354383, 7752.0697516298405, 7838.451308408356, 7906.288434040964, 8340.666373344999, 8371.623276952674, 8481.448705834102, 8514.914850851412, 8567.61445734931, 7399.59302238382, 7558.206388329147, 7584.582847943196, 7631.3513351365755, 7981.1619779924595, 7057.117860267466, 7136.286371362822, 7285.344319011102, 7385.150707668687, 7550.735724249625, 6929.965350173418, 7090.503664743418, 7119.644017799193, 7128.429725622042, 7185.137783466018, 4883.169861123689, 4901.607871370353, 5012.77442515095, 5035.496450354935, 5053.216751403538, 4330.805113769951, 5010.023045506091, 5047.974760126176, 5097.0315640028275, 5239.580833533384], "value": 4757.711406953025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4990214482566, 339.8148009334912, 342.6299596435849, 345.3801670166917, 352.36574166500327, 6537.7058032388595, 7028.367446929776, 7068.505204635671, 7080.96459517703, 7120.715171393138, 5570.3315602127705, 6989.615571143585, 7001.334873187039, 7069.787906362804, 7089.078419805431, 4892.608591312704, 4990.0, 5120.180771076629, 5149.40781810091, 5157.7936882524655, 5124.128898087334, 5163.845084647448, 5179.870503237412, 5181.6113791465605, 5206.843794686166, 5136.871578210537, 5142.280080788692, 5143.3570803649545, 5156.432792392834, 5164.457731938149, 5145.742712864342, 5148.897022059576, 5159.993801208747, 5162.406323272815, 5180.818671346522, 3679.558452985632, 4337.002489427449, 4410.647148228134, 4415.51429342772, 4422.159789639958, 6653.489163064192, 6678.332166783332, 6817.659117044128, 6823.624700641462, 6888.483363747739, 5965.940340596625, 6040.456358927674, 6050.69746512677, 6051.818445446644, 6070.119832624289, 7562.886556701654, 7566.054243219598, 7587.0, 7608.8478230435085, 7613.42899282556, 4991.251312303148, 5003.024410240005, 5010.423801262828, 5012.924806127911, 5015.974920125413, 7800.336971357441, 8044.557549334842, 8095.069067057305, 8105.432619716622, 8136.877946830802, 5054.660514963538, 5109.20807274873, 5118.181091025418, 5123.666961647481, 5124.5131712487255, 5206.114960456732, 5211.609129315317, 5219.19102539107, 5226.425093239741, 5249.553787927993, 6062.636241825505, 6063.757449701962, 6065.2418447694035, 6065.4541091302, 6081.179040829431, 7633.69465221385, 7655.043119610049, 7658.8085297868, 7661.808454788675, 7674.232576742281, 1752.807191208966, 1793.3454289184615, 1807.1777341309673, 1823.8996855172827, 1824.3888297420247, 1152.0610702277618, 1154.417019405195, 1154.6593754842343, 1162.7267592115845, 1166.5392170092935, 7181.0, 7193.3166349196745, 7216.0, 7236.710531578678, 7242.818929526698, 6266.49868010558, 6388.520860935449, 7574.356179724785, 7871.0, 7874.212578742195, 6536.908189379353, 6668.699908504129, 7238.855222895512, 7255.201927787939, 7322.0, 4183.414321994923, 4212.326027835532, 4226.387173859773, 4235.30117530604, 4265.55211702773, 8327.417080804407, 8364.707235246737, 8403.789905252417, 8411.579421028924, 8430.32557395407, 7918.643661035152, 8281.710140145187, 8288.254057134887, 8310.667573297122, 8343.123971982854, 8301.29438997692, 8368.874466883002, 8380.455270407405, 8390.951131108734, 8422.831543369099, 7980.840383192188, 7983.84032319362, 7990.881276621394, 8006.639701213576, 8007.199280071946, 7641.0, 7747.496412733154, 7875.291223789886, 7890.881636775338, 7892.605369731606, 8332.250097491255, 8333.458325208841, 8353.122922093336, 8354.913861198249, 8377.246047855722, 5120.871978200575, 5122.436531981553, 5125.384953805567, 5133.512316329943, 5135.614828887774, 6050.334463209131, 7952.36381089523, 7962.124166341582, 7972.521648701097, 7993.760187194393, 5495.340559132929, 6961.37347638715, 7282.198958114709, 7697.499662521918, 7724.266194711493, 7676.501027433199, 7685.538867667958, 7703.961480192564, 7710.306072453506, 7733.7679869604, 7503.474756766974, 7528.360089392463, 7546.698132074655, 7550.169481357156, 7565.508241964255, 7657.540547567164, 7658.69365225407, 7672.846543068996, 7675.53946763196, 7704.152543220129, 6980.53408784161, 7228.0, 7486.6256687166515, 7548.320651141424, 7579.090509138939], "value": 5554.453966089037, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.6377726922964, 590.3613862120454, 690.1407747354544, 721.5310048468494, 773.3542492019162, 15057.849421505782, 15170.84829151711, 15304.311305991228, 15346.846531534682, 15371.154586497738, 14016.579502614937, 14025.719485610281, 14094.36575354109, 14106.92946535266, 14158.787618185735, 781.0549235425142, 792.9770595931242, 939.0, 953.7472569769017, 976.9853452198187, 946.6781294359917, 948.7296120605629, 948.8339540580405, 953.3945944325369, 957.8371676814924, 1008.8991100889889, 1018.0532105142215, 1025.7486915705624, 1029.696239609317, 1032.6695457453618, 977.7164622259536, 1021.2748948246754, 1023.5854478936043, 1025.5590096258607, 1026.3892983674702, 747.8279995601042, 761.375671949002, 767.3860911271016, 768.2547928509393, 768.389130641136, 11623.360715160663, 14979.700405991927, 14994.100353978796, 15029.473968411054, 15089.24553772307, 13344.132631378929, 13344.599662010156, 13352.33238338089, 13475.66310842227, 13479.056466047381, 8717.0, 8868.733937981871, 8924.687635932776, 8982.0, 8996.010438851721, 3571.23218508022, 3622.9094272643133, 3659.5608526976666, 3680.5031320771886, 3868.3810590305416, 78895.6055219726, 81492.59253703753, 81671.18328816695, 82518.58740706259, 82707.5864620679, 9737.805243895224, 9830.0, 9943.204543636492, 10034.899651003543, 10186.490675466197, 23140.65289020666, 23239.7676023241, 23251.418714531934, 23276.65085023726, 23324.883375583013, 6210.72051757672, 7235.2402997684485, 7431.368333691588, 7649.196834332426, 7653.770386888402, 3970.5830887756947, 4243.830246790156, 4256.106217694257, 4304.647288460092, 4304.80628371724, 3659.0669379308106, 3676.4117741161285, 3696.9815150924073, 3709.3323201823932, 3711.703063754947, 654.9410553050249, 661.4179522020592, 669.310610071627, 678.5284227461866, 680.5100327764002, 555.2199160179954, 573.7274794472676, 625.9311475737666, 629.5058379172327, 645.0936434309803, 8251.628676709563, 8385.916140838513, 8399.496030238082, 8418.200270974248, 8574.0, 602.0, 623.6195920488499, 623.7255607532671, 635.4948063371596, 649.0556240669814, 3924.6467817895955, 3997.8001099944886, 4008.997750562359, 4012.3179059559943, 4084.3465045593157, 89634.55182724044, 91543.0, 91613.0, 93030.0, 94054.52972735092, 76888.0, 77944.61027694939, 78330.6083469579, 79194.0, 82528.17471825205, 73833.0, 75295.49409011789, 75609.0, 76765.0, 77295.61352193203, 8706.651733930572, 8875.866861996947, 8917.821643567222, 8922.464652120894, 8941.46351218929, 50629.49370506248, 50850.74574627103, 51933.0, 53503.19745203903, 54051.0, 68854.65572672104, 69445.0, 69927.0, 70328.0, 72195.0, 10832.891671083189, 10936.0, 11228.214025018171, 11292.943535282271, 11416.828747568627, 12120.696982575506, 12194.451249693962, 12392.876071239532, 12415.751684966432, 12961.898238649443, 11575.578704279857, 11614.6515604532, 11626.360550169484, 11672.533098675958, 11945.104117191071, 11729.706757330794, 11824.940875295568, 11876.940615296868, 11938.164328496921, 12391.75216495683, 10935.617253396093, 11109.888901110886, 11812.0, 12015.038796896053, 12260.693482663004, 9711.5144242789, 9773.0, 9923.206143508358, 9946.502674866373, 10048.899511004796, 9603.087706667855, 9785.951070244602, 9866.013398660076, 9949.235538118293, 9959.153471954674], "value": 7093.992292188518, "unit": "score"}], "name": "dromaeo_css", "value": 7639.207417174071, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 169.0, 111.0, 129.0, 173.0, 164.0, 107.0, 116.0, 116.0, 115.0], "value": 132.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 143.0, 155.0, 122.0, 143.0, 125.0, 170.0, 146.0, 143.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 234.0, 195.0, 195.0, 194.0, 194.0, 194.0, 196.0, 227.0, 283.0], "value": 210.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 71.0, 82.0, 142.0, 57.0, 57.0, 56.0, 67.0, 126.0, 58.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 88.0, 117.0, 75.0, 115.0, 126.0, 164.0, 77.0, 68.0, 162.0], "value": 107.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 86.0, 108.0, 131.0, 115.0, 86.0, 90.0, 85.0, 87.0, 87.0], "value": 99.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 97.0, 138.0, 94.0, 109.0, 95.0, 94.0, 94.0, 94.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 98.0, 93.0, 90.0, 118.0, 142.0, 94.0, 89.0, 91.0], "value": 99.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 65.0, 65.0, 65.0, 66.0, 66.0, 79.0, 60.0, 58.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 84.0, 107.0, 105.0, 74.0, 76.0, 59.0, 62.0, 77.0, 93.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 83.0, 82.0, 83.0, 82.0, 80.0, 80.0, 104.0, 87.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 122.0, 148.0, 146.0, 143.0, 145.0, 157.0, 153.0, 168.0, 165.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 159.0, 161.0, 164.0, 164.0, 159.0, 162.0, 165.0, 163.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 68.0, 71.0, 65.0, 63.0, 69.0, 66.0, 69.0, 81.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1581.5000000000002, "alertThreshold": 2.0}]} 15:53:52 INFO - Return code: 0 15:53:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:53:52 ERROR - # TBPL SUCCESS # 15:53:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:53:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:53:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:53:52 INFO - 2016-07-04 15:53:52.118 screenresolution[2038:14676] starting screenresolution argv=screenresolution get 15:53:52 INFO - 2016-07-04 15:53:52.121 screenresolution[2038:14676] Display 0: 1600x1200x32@60 15:53:52 INFO - 2016-07-04 15:53:52.126 screenresolution[2039:14679] starting screenresolution argv=screenresolution list 15:53:52 INFO - Available Modes on Display 0 15:53:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:53:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:53:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:53:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:53:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:53:52 INFO - Intel Iris: 15:53:52 INFO - Chipset Model: Intel Iris 15:53:52 INFO - Type: GPU 15:53:52 INFO - Bus: Built-In 15:53:52 INFO - VRAM (Dynamic, Max): 1536 MB 15:53:52 INFO - Vendor: Intel (0x8086) 15:53:52 INFO - Device ID: 0x0a2e 15:53:52 INFO - Revision ID: 0x0009 15:53:52 INFO - Displays: 15:53:52 INFO - Display: 15:53:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:53:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:53:52 INFO - Display Serial Number: 1600x1200 60 15:53:52 INFO - Main Display: Yes 15:53:52 INFO - Mirror: Off 15:53:52 INFO - Online: Yes 15:53:52 INFO - Rotation: Supported 15:53:52 INFO - Return code: 0 15:53:52 INFO - Running post-action listener: _resource_record_post_action 15:53:52 INFO - Running post-run listener: _resource_record_post_run 15:53:53 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 483328; Write bytes: 495995392; Read time: 10; Write time: 1568 15:53:53 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194585088; Write bytes: 194596864; Read time: 17656; Write time: 440 15:53:53 INFO - run-tests - Wall time: 1170s; CPU: 54.0%; Read bytes: 458752; Write bytes: 300390912; Read time: 9; Write time: 1122 15:53:53 INFO - Running post-run listener: _upload_blobber_files 15:53:53 INFO - Blob upload gear active. 15:53:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:53:53 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 15:53:53 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'] 15:53:53 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 15:53:53 INFO - (blobuploader) - INFO - Open directory for files ... 15:53:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:53:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:53:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:54 INFO - (blobuploader) - INFO - Done attempting. 15:53:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:53:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:53:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:55 INFO - (blobuploader) - INFO - Done attempting. 15:53:55 INFO - (blobuploader) - INFO - Iteration through files over. 15:53:55 INFO - Return code: 0 15:53:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:53:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:53:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/88b81a6f8287b86806ee0934e6072800ff049eae53b40208951413058c9e2f84054ffdf65507c98c892ca92275277b660ad604166839da7e8f8e63fc31afd392", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05609ba618327ac830b70822b407a361acc0e83f4a5478d17cdf64105952a727ccd5983dbeced4bb2fae1a29164e2f7806e8f00cebeec868a7f40ea8234ca24e"} 15:53:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:53:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:53:55 INFO - Contents: 15:53:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/88b81a6f8287b86806ee0934e6072800ff049eae53b40208951413058c9e2f84054ffdf65507c98c892ca92275277b660ad604166839da7e8f8e63fc31afd392", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05609ba618327ac830b70822b407a361acc0e83f4a5478d17cdf64105952a727ccd5983dbeced4bb2fae1a29164e2f7806e8f00cebeec868a7f40ea8234ca24e"} 15:53:55 INFO - Running post-run listener: copy_logs_to_upload_dir 15:53:55 INFO - Copying logs to upload dir... 15:53:55 INFO - mkdir: /builds/slave/test/build/upload/logs 15:53:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.763250 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-04 15:53:55.538235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 15:53:55.542074) ========= 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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/88b81a6f8287b86806ee0934e6072800ff049eae53b40208951413058c9e2f84054ffdf65507c98c892ca92275277b660ad604166839da7e8f8e63fc31afd392", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05609ba618327ac830b70822b407a361acc0e83f4a5478d17cdf64105952a727ccd5983dbeced4bb2fae1a29164e2f7806e8f00cebeec868a7f40ea8234ca24e"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011230 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467639957/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/88b81a6f8287b86806ee0934e6072800ff049eae53b40208951413058c9e2f84054ffdf65507c98c892ca92275277b660ad604166839da7e8f8e63fc31afd392", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05609ba618327ac830b70822b407a361acc0e83f4a5478d17cdf64105952a727ccd5983dbeced4bb2fae1a29164e2f7806e8f00cebeec868a7f40ea8234ca24e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 15:53:55.574589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:53:55.574903) ========= 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.ZBMO0XkOYL/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.PT8xR1V1Nt/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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.004569 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 15:53:55.623278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 15:53:55.623584) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 15:53:55.623906) ========= ========= Total master_lag: 0.21 =========