builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0387 starttime: 1467032268.73 results: success (0) buildid: 20160624143557 builduid: 67b95f07284347e7aea2678b4c3b20e6 revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.735197) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.735555) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.735835) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.777989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.778261) ========= 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.KV8tjsGEfp/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.WZZal4SkcK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-27 05:57:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.02M=0.001s 2016-06-27 05:57:49 (8.02 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.485080 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:49.287134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:49.287453) ========= 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.KV8tjsGEfp/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.WZZal4SkcK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.020972 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:49.335322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 05:57:49.335660) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 229741b7de0485ca56b91e0e657fe5d37dbbc98f --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 229741b7de0485ca56b91e0e657fe5d37dbbc98f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KV8tjsGEfp/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.WZZal4SkcK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-27 05:57:49,417 truncating revision to first 12 chars 2016-06-27 05:57:49,417 Setting DEBUG logging. 2016-06-27 05:57:49,417 attempt 1/10 2016-06-27 05:57:49,417 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/229741b7de04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 05:57:50,419 unpacking tar archive at: mozilla-beta-229741b7de04/testing/mozharness/ program finished with exit code 0 elapsedTime=1.268154 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 05:57:50.626128) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.626432) ========= script_repo_revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.626840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.627104) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.645365) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-06-27 05:57:50.645660) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KV8tjsGEfp/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.WZZal4SkcK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 05:57:50 INFO - MultiFileLogger online at 20160627 05:57:50 in /builds/slave/test 05:57:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:57:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:50 INFO - {'append_to_log': False, 05:57:50 INFO - 'base_work_dir': '/builds/slave/test', 05:57:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:57:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:50 INFO - 'branch': 'Mozilla-Beta', 05:57:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:50 INFO - 'config_files': ('talos/mac_config.py',), 05:57:50 INFO - 'default_actions': ('clobber', 05:57:50 INFO - 'read-buildbot-config', 05:57:50 INFO - 'download-and-extract', 05:57:50 INFO - 'populate-webroot', 05:57:50 INFO - 'create-virtualenv', 05:57:50 INFO - 'install', 05:57:50 INFO - 'run-tests'), 05:57:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:50 INFO - 'download_minidump_stackwalk': True, 05:57:50 INFO - 'download_symbols': 'ondemand', 05:57:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:50 INFO - 'installer_path': 'installer.exe', 05:57:50 INFO - 'log_level': 'info', 05:57:50 INFO - 'log_name': 'talos', 05:57:50 INFO - 'log_to_console': True, 05:57:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:57:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:57:50 INFO - 'opt_config_files': (), 05:57:50 INFO - 'pip_index': False, 05:57:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:57:50 INFO - 'cmd': ('bash', 05:57:50 INFO - '-c', 05:57:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:57:50 INFO - 'enabled': True, 05:57:50 INFO - 'halt_on_failure': False, 05:57:50 INFO - 'name': 'check_screen_resolution'},), 05:57:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:57:50 INFO - 'cmd': ('bash', 05:57:50 INFO - '-c', 05:57:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:57:50 INFO - 'enabled': True, 05:57:50 INFO - 'halt_on_failure': False, 05:57:50 INFO - 'name': 'check_screen_resolution'},), 05:57:50 INFO - 'run_cmd_checks_enabled': True, 05:57:50 INFO - 'sps_profile': False, 05:57:50 INFO - 'sps_profile_interval': 0, 05:57:50 INFO - 'suite': 'dromaeojs', 05:57:50 INFO - 'system_bits': '32', 05:57:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:50 INFO - 'title': 't-yosemite-r7-0387', 05:57:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:50 INFO - 'use_talos_json': True, 05:57:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:50 INFO - 'work_dir': 'build'} 05:57:50 INFO - ##### 05:57:50 INFO - ##### Running clobber step. 05:57:50 INFO - ##### 05:57:50 INFO - Running pre-action listener: _resource_record_pre_action 05:57:50 INFO - Running main action method: clobber 05:57:50 INFO - rmtree: /builds/slave/test/build 05:57:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:52 INFO - Running post-action listener: _resource_record_post_action 05:57:52 INFO - ##### 05:57:52 INFO - ##### Running read-buildbot-config step. 05:57:52 INFO - ##### 05:57:52 INFO - Running pre-action listener: _resource_record_pre_action 05:57:52 INFO - Running main action method: read_buildbot_config 05:57:52 INFO - Using buildbot properties: 05:57:52 INFO - { 05:57:52 INFO - "project": "", 05:57:52 INFO - "product": "firefox", 05:57:52 INFO - "script_repo_revision": "production", 05:57:52 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:57:52 INFO - "repository": "", 05:57:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:57:52 INFO - "buildid": "20160624143557", 05:57:52 INFO - "pgo_build": "False", 05:57:52 INFO - "basedir": "/builds/slave/test", 05:57:52 INFO - "buildnumber": 6, 05:57:52 INFO - "slavename": "t-yosemite-r7-0387", 05:57:52 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:57:52 INFO - "platform": "yosemite_r7", 05:57:52 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:57:52 INFO - "branch": "mozilla-beta", 05:57:52 INFO - "repo_path": "releases/mozilla-beta", 05:57:52 INFO - "revision": "229741b7de0485ca56b91e0e657fe5d37dbbc98f", 05:57:52 INFO - "stage_platform": "macosx64", 05:57:52 INFO - "builduid": "67b95f07284347e7aea2678b4c3b20e6", 05:57:52 INFO - "slavebuilddir": "test" 05:57:52 INFO - } 05:57:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 05:57:52 INFO - Running post-action listener: _resource_record_post_action 05:57:52 INFO - ##### 05:57:52 INFO - ##### Running download-and-extract step. 05:57:52 INFO - ##### 05:57:52 INFO - Running pre-action listener: _resource_record_pre_action 05:57:52 INFO - Running main action method: download_and_extract 05:57:52 INFO - mkdir: /builds/slave/test/build/tests 05:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:52 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 05:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 05:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 05:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/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 05:57:55 INFO - Downloaded 1165 bytes. 05:57:55 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 05:57:55 INFO - Using the following test package requirements: 05:57:55 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 05:57:55 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:55 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 05:57:55 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:55 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 05:57:55 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:57:55 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:55 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 05:57:55 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 05:57:55 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:55 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 05:57:55 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:55 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 05:57:55 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:55 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 05:57:55 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:55 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 05:57:55 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 05:57: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')]} 05:57:55 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:57:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:57:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:57:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 05:57:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/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 05:57:58 INFO - Downloaded 18344069 bytes. 05:57:58 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'] 05:57:58 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 05:58:01 INFO - Return code: 0 05:58:01 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 05:58:01 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')]} 05:58:01 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:58:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/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 05:58:13 INFO - Downloaded 18344069 bytes. 05:58:13 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'] 05:58:13 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 05:58:17 INFO - Return code: 0 05:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:17 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:58:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 05:58:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 05:58:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 05:58:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/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 05:58:18 INFO - Downloaded 10840145 bytes. 05:58:18 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'] 05:58:18 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 05:58:18 INFO - Return code: 0 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:18 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 05:58:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:58:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:58:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 05:58:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 05:58:21 INFO - Downloaded 86227039 bytes. 05:58:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:58:21 INFO - mkdir: /builds/slave/test/properties 05:58:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:21 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:21 INFO - Contents: 05:58:21 INFO - build_url:https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:58:22 INFO - Running post-action listener: _resource_record_post_action 05:58:22 INFO - Running post-action listener: set_extra_try_arguments 05:58:22 INFO - ##### 05:58:22 INFO - ##### Running populate-webroot step. 05:58:22 INFO - ##### 05:58:22 INFO - Running pre-action listener: _resource_record_pre_action 05:58:22 INFO - Running main action method: populate_webroot 05:58:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:22 INFO - '--tppagecycles', 05:58:22 INFO - '7'], 05:58:22 INFO - 'tests': ['tsvgm']}}, 05:58:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:22 INFO - 'talos_options': ['--disable-e10s'], 05:58:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:22 INFO - 'talos_options': ['--disable-e10s'], 05:58:22 INFO - 'tests': ['damp', 'tps']}, 05:58:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:22 INFO - 'tests': ['damp', 'tps']}, 05:58:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:22 INFO - 'tests': ['dromaeo_dom']}, 05:58:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:22 INFO - 'tests': ['a11yr', 05:58:22 INFO - 'ts_paint', 05:58:22 INFO - 'tpaint', 05:58:22 INFO - 'sessionrestore', 05:58:22 INFO - 'sessionrestore_no_auto_restore', 05:58:22 INFO - 'tabpaint']}, 05:58:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:22 INFO - 'ts_paint', 05:58:22 INFO - 'tpaint', 05:58:22 INFO - 'sessionrestore', 05:58:22 INFO - 'sessionrestore_no_auto_restore', 05:58:22 INFO - 'tabpaint']}, 05:58:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:22 INFO - 'ts_paint', 05:58:22 INFO - 'tpaint', 05:58:22 INFO - 'sessionrestore', 05:58:22 INFO - 'sessionrestore_no_auto_restore', 05:58:22 INFO - 'tabpaint']}, 05:58:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:22 INFO - 'ts_paint', 05:58:22 INFO - 'tpaint', 05:58:22 INFO - 'sessionrestore', 05:58:22 INFO - 'sessionrestore_no_auto_restore', 05:58:22 INFO - 'tabpaint']}, 05:58:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:22 INFO - 'tests': ['a11yr', 05:58:22 INFO - 'ts_paint', 05:58:22 INFO - 'tpaint', 05:58:22 INFO - 'sessionrestore', 05:58:22 INFO - 'sessionrestore_no_auto_restore', 05:58:22 INFO - 'tabpaint']}, 05:58:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:22 INFO - 'tests': ['a11yr', 05:58:22 INFO - 'ts_paint', 05:58:22 INFO - 'tpaint', 05:58:22 INFO - 'sessionrestore', 05:58:22 INFO - 'sessionrestore_no_auto_restore', 05:58:22 INFO - 'tabpaint']}, 05:58:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:22 INFO - 'tests': ['tsvgx', 05:58:22 INFO - 'tsvgr_opacity', 05:58:22 INFO - 'tart', 05:58:22 INFO - 'tscrollx', 05:58:22 INFO - 'cart']}, 05:58:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:22 INFO - 'tsvgr_opacity', 05:58:22 INFO - 'tart', 05:58:22 INFO - 'tscrollx', 05:58:22 INFO - 'cart']}, 05:58:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:22 INFO - 'talos_options': ['--disable-e10s'], 05:58:22 INFO - 'tests': ['tp5o']}, 05:58:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:22 INFO - 'tests': ['tp5o']}, 05:58:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:22 INFO - 'talos_options': ['--disable-e10s', 05:58:22 INFO - '--xperf_path', 05:58:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:22 INFO - 'tests': ['tp5n']}, 05:58:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:22 INFO - 'talos_options': ['--xperf_path', 05:58:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:22 INFO - 'tests': ['tp5n']}}, 05:58:22 INFO - 'talos.zip': {'path': '', 05:58:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:22 INFO - Running post-action listener: _resource_record_post_action 05:58:22 INFO - ##### 05:58:22 INFO - ##### Running create-virtualenv step. 05:58:22 INFO - ##### 05:58:22 INFO - Running pre-action listener: _resource_record_pre_action 05:58:22 INFO - Running main action method: create_virtualenv 05:58:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:22 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 05:58:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:22 INFO - Using real prefix '/tools/python27' 05:58:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:25 INFO - Installing pip.................done. 05:58:25 INFO - Return code: 0 05:58:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:25 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')]} 05:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:25 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')]} 05:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:25 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 0x104e40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e50420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b0577850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cdfe00>, '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 0x104b48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cdab20>, '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.KV8tjsGEfp/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.WZZal4SkcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 05:58:25 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 05:58:25 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 05:58:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KV8tjsGEfp/Render', 05:58:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:25 INFO - 'HOME': '/Users/cltbld', 05:58:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:25 INFO - 'LOGNAME': 'cltbld', 05:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:25 INFO - 'MOZ_NO_REMOTE': '1', 05:58:25 INFO - 'NO_EM_RESTART': '1', 05:58:25 INFO - 'PAGER': '/bin/cat', 05:58:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:25 INFO - 'PWD': '/builds/slave/test', 05:58:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:25 INFO - 'SHELL': '/bin/bash', 05:58:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZZal4SkcK/Listeners', 05:58:25 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 05:58:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:25 INFO - 'USER': 'cltbld', 05:58:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:25 INFO - 'XPC_FLAGS': '0x0', 05:58:25 INFO - 'XPC_SERVICE_NAME': '0', 05:58:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:26 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 05:58:26 INFO - Cleaning up... 05:58:26 INFO - Return code: 0 05:58:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:58:26 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')]} 05:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:26 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')]} 05:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:26 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 0x104e40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e50420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b0577850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cdfe00>, '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 0x104b48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cdab20>, '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.KV8tjsGEfp/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.WZZal4SkcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 05:58:26 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 05:58:26 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 05:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KV8tjsGEfp/Render', 05:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:26 INFO - 'HOME': '/Users/cltbld', 05:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:26 INFO - 'LOGNAME': 'cltbld', 05:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:26 INFO - 'MOZ_NO_REMOTE': '1', 05:58:26 INFO - 'NO_EM_RESTART': '1', 05:58:26 INFO - 'PAGER': '/bin/cat', 05:58:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:26 INFO - 'PWD': '/builds/slave/test', 05:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:26 INFO - 'SHELL': '/bin/bash', 05:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZZal4SkcK/Listeners', 05:58:26 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 05:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:26 INFO - 'USER': 'cltbld', 05:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:26 INFO - 'XPC_FLAGS': '0x0', 05:58:26 INFO - 'XPC_SERVICE_NAME': '0', 05:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:26 INFO - Downloading/unpacking psutil>=0.7.1 05:58:26 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 05:58:26 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 05:58:26 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 05:58:26 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 05:58:26 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 05:58:26 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 05:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:29 INFO - Installing collected packages: psutil 05:58:29 INFO - Running setup.py install for psutil 05:58:29 INFO - building 'psutil._psutil_osx' extension 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 INFO - building 'psutil._psutil_posix' extension 05:58:29 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 05:58:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:58:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:58:29 INFO - ^ 05:58:30 INFO - 1 warning generated. 05:58:30 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 05:58:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:30 INFO - Successfully installed psutil 05:58:30 INFO - Cleaning up... 05:58:30 INFO - Return code: 0 05:58:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:30 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 0x104e40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e50420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b0577850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cdfe00>, '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 0x104b48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cdab20>, '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.KV8tjsGEfp/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.WZZal4SkcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 05:58:30 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 05:58:30 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 05:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KV8tjsGEfp/Render', 05:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:30 INFO - 'HOME': '/Users/cltbld', 05:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:30 INFO - 'LOGNAME': 'cltbld', 05:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:30 INFO - 'MOZ_NO_REMOTE': '1', 05:58:30 INFO - 'NO_EM_RESTART': '1', 05:58:30 INFO - 'PAGER': '/bin/cat', 05:58:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:30 INFO - 'PWD': '/builds/slave/test', 05:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:30 INFO - 'SHELL': '/bin/bash', 05:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZZal4SkcK/Listeners', 05:58:30 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 05:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:30 INFO - 'USER': 'cltbld', 05:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:30 INFO - 'XPC_FLAGS': '0x0', 05:58:30 INFO - 'XPC_SERVICE_NAME': '0', 05:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:58:32 INFO - Installing collected packages: mozsystemmonitor 05:58:32 INFO - Running setup.py install for mozsystemmonitor 05:58:33 INFO - Successfully installed mozsystemmonitor 05:58:33 INFO - Cleaning up... 05:58:33 INFO - Return code: 0 05:58:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:33 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 0x104e40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e50420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b0577850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cdfe00>, '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 0x104b48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cdab20>, '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.KV8tjsGEfp/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.WZZal4SkcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 05:58:33 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 05:58:33 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 05:58:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KV8tjsGEfp/Render', 05:58:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:33 INFO - 'HOME': '/Users/cltbld', 05:58:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:33 INFO - 'LOGNAME': 'cltbld', 05:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:33 INFO - 'MOZ_NO_REMOTE': '1', 05:58:33 INFO - 'NO_EM_RESTART': '1', 05:58:33 INFO - 'PAGER': '/bin/cat', 05:58:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:33 INFO - 'PWD': '/builds/slave/test', 05:58:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:33 INFO - 'SHELL': '/bin/bash', 05:58:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZZal4SkcK/Listeners', 05:58:33 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 05:58:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:33 INFO - 'USER': 'cltbld', 05:58:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:33 INFO - 'XPC_FLAGS': '0x0', 05:58:33 INFO - 'XPC_SERVICE_NAME': '0', 05:58:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:35 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:37 INFO - Downloading docopt-0.6.1.tar.gz 05:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:37 INFO - Running setup.py install for blobuploader 05:58:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:37 INFO - Running setup.py install for requests 05:58:37 INFO - Running setup.py install for docopt 05:58:37 INFO - Successfully installed blobuploader requests docopt 05:58:37 INFO - Cleaning up... 05:58:38 INFO - Return code: 0 05:58:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 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 0x104e40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e50420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b0577850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cdfe00>, '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 0x104b48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cdab20>, '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.KV8tjsGEfp/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.WZZal4SkcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 05:58:38 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 05:58:38 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 05:58:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KV8tjsGEfp/Render', 05:58:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:38 INFO - 'HOME': '/Users/cltbld', 05:58:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:38 INFO - 'LOGNAME': 'cltbld', 05:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:38 INFO - 'MOZ_NO_REMOTE': '1', 05:58:38 INFO - 'NO_EM_RESTART': '1', 05:58:38 INFO - 'PAGER': '/bin/cat', 05:58:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:38 INFO - 'PWD': '/builds/slave/test', 05:58:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:38 INFO - 'SHELL': '/bin/bash', 05:58:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZZal4SkcK/Listeners', 05:58:38 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 05:58:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:38 INFO - 'USER': 'cltbld', 05:58:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:38 INFO - 'XPC_FLAGS': '0x0', 05:58:38 INFO - 'XPC_SERVICE_NAME': '0', 05:58:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-7oL6eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-8A7r2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-H98Anv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-9NkVGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-OjfRJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-OhUSDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-zhkxsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-67EuvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-edMZh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-NO2jEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-5l08Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-N5dS9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-r69Ejw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-mcn7BO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-1I9dAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-mfwvZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:40 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-B24Ycm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:40 INFO - Running setup.py install for manifestparser 05:58:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Running setup.py install for mozcrash 05:58:40 INFO - Running setup.py install for mozdebug 05:58:40 INFO - Running setup.py install for mozdevice 05:58:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Running setup.py install for mozfile 05:58:40 INFO - Running setup.py install for mozhttpd 05:58:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozinfo 05:58:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozInstall 05:58:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozleak 05:58:41 INFO - Running setup.py install for mozlog 05:58:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for moznetwork 05:58:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozprocess 05:58:41 INFO - Running setup.py install for mozprofile 05:58:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:42 INFO - Running setup.py install for mozrunner 05:58:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:42 INFO - Running setup.py install for mozscreenshot 05:58:42 INFO - Running setup.py install for moztest 05:58:42 INFO - Running setup.py install for mozversion 05:58:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:42 INFO - Cleaning up... 05:58:42 INFO - Return code: 0 05:58:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:42 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')]} 05:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:42 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')]} 05:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:42 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 0x104e40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e50420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b0577850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cdfe00>, '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 0x104b48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cdab20>, '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.KV8tjsGEfp/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.WZZal4SkcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 05:58:42 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 05:58:42 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 05:58:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KV8tjsGEfp/Render', 05:58:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:42 INFO - 'HOME': '/Users/cltbld', 05:58:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:42 INFO - 'LOGNAME': 'cltbld', 05:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:42 INFO - 'MOZ_NO_REMOTE': '1', 05:58:42 INFO - 'NO_EM_RESTART': '1', 05:58:42 INFO - 'PAGER': '/bin/cat', 05:58:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:42 INFO - 'PWD': '/builds/slave/test', 05:58:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:42 INFO - 'SHELL': '/bin/bash', 05:58:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZZal4SkcK/Listeners', 05:58:42 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 05:58:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:42 INFO - 'USER': 'cltbld', 05:58:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:42 INFO - 'XPC_FLAGS': '0x0', 05:58:42 INFO - 'XPC_SERVICE_NAME': '0', 05:58:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:42 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-UrmiSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-CU93yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-aEBUKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-IEnQrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-8z8N8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-n9rU_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-XqMkrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-oE23AL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-s3YBlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-GxAWdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:44 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)) 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:44 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-n4E8St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:44 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)) 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:44 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-pVJLZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:44 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)) 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:44 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-OBjS6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:44 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)) 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:44 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-KgsJFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:44 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)) 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:44 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-mYOmzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:44 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)) 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:44 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-1QXObV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:44 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)) 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:44 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-43bs7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:44 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)) 05:58:44 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)) 05:58:44 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)) 05:58:44 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)) 05:58:44 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)) 05:58:44 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)) 05:58:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:47 INFO - Downloading blessings-1.6.tar.gz 05:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:47 INFO - Installing collected packages: blessings 05:58:47 INFO - Running setup.py install for blessings 05:58:47 INFO - Successfully installed blessings 05:58:47 INFO - Cleaning up... 05:58:47 INFO - Return code: 0 05:58:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:47 INFO - Reading from file tmpfile_stdout 05:58:47 INFO - Current package versions: 05:58:47 INFO - blessings == 1.6 05:58:47 INFO - blobuploader == 1.2.4 05:58:47 INFO - docopt == 0.6.1 05:58:47 INFO - manifestparser == 1.1 05:58:47 INFO - mozInstall == 1.12 05:58:47 INFO - mozcrash == 0.17 05:58:47 INFO - mozdebug == 0.1 05:58:47 INFO - mozdevice == 0.48 05:58:47 INFO - mozfile == 1.2 05:58:47 INFO - mozhttpd == 0.7 05:58:47 INFO - mozinfo == 0.9 05:58:47 INFO - mozleak == 0.1 05:58:47 INFO - mozlog == 3.1 05:58:47 INFO - moznetwork == 0.27 05:58:47 INFO - mozprocess == 0.22 05:58:47 INFO - mozprofile == 0.28 05:58:47 INFO - mozrunner == 6.11 05:58:47 INFO - mozscreenshot == 0.1 05:58:47 INFO - mozsystemmonitor == 0.0 05:58:47 INFO - moztest == 0.7 05:58:47 INFO - mozversion == 1.4 05:58:47 INFO - psutil == 3.1.1 05:58:47 INFO - requests == 1.2.3 05:58:47 INFO - wsgiref == 0.1.2 05:58:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:47 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 0x104e40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e50420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b0577850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cdfe00>, '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 0x104b48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cdab20>, '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.KV8tjsGEfp/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.WZZal4SkcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 05:58:47 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 05:58:47 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 05:58:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KV8tjsGEfp/Render', 05:58:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:47 INFO - 'HOME': '/Users/cltbld', 05:58:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:47 INFO - 'LOGNAME': 'cltbld', 05:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:47 INFO - 'MOZ_NO_REMOTE': '1', 05:58:47 INFO - 'NO_EM_RESTART': '1', 05:58:47 INFO - 'PAGER': '/bin/cat', 05:58:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:47 INFO - 'PWD': '/builds/slave/test', 05:58:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:47 INFO - 'SHELL': '/bin/bash', 05:58:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZZal4SkcK/Listeners', 05:58:47 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 05:58:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:47 INFO - 'USER': 'cltbld', 05:58:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:47 INFO - 'XPC_FLAGS': '0x0', 05:58:47 INFO - 'XPC_SERVICE_NAME': '0', 05:58:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:48 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)) 05:58:48 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)) 05:58:48 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)) 05:58:48 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)) 05:58:48 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)) 05:58:48 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)) 05:58:48 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)) 05:58:48 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)) 05:58:48 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)) 05:58:48 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)) 05:58:48 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)) 05:58:48 INFO - Cleaning up... 05:58:48 INFO - Return code: 0 05:58:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:48 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')]} 05:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:48 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')]} 05:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:48 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 0x104e40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e50420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b0577850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cdfe00>, '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 0x104b48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cdab20>, '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.KV8tjsGEfp/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.WZZal4SkcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 05:58:48 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 05:58:48 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 05:58:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KV8tjsGEfp/Render', 05:58:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:48 INFO - 'HOME': '/Users/cltbld', 05:58:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:48 INFO - 'LOGNAME': 'cltbld', 05:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:48 INFO - 'MOZ_NO_REMOTE': '1', 05:58:48 INFO - 'NO_EM_RESTART': '1', 05:58:48 INFO - 'PAGER': '/bin/cat', 05:58:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:48 INFO - 'PWD': '/builds/slave/test', 05:58:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:48 INFO - 'SHELL': '/bin/bash', 05:58:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZZal4SkcK/Listeners', 05:58:48 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 05:58:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:48 INFO - 'USER': 'cltbld', 05:58:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:48 INFO - 'XPC_FLAGS': '0x0', 05:58:48 INFO - 'XPC_SERVICE_NAME': '0', 05:58:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:48 INFO - Downloading/unpacking jsonschema 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:50 INFO - Downloading/unpacking functools32 (from jsonschema) 05:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:51 INFO - warning: no files found matching '*.txt' 05:58:51 INFO - no previously-included directories found matching 'build' 05:58:51 INFO - no previously-included directories found matching 'dist' 05:58:51 INFO - no previously-included directories found matching '.git*' 05:58:51 INFO - Installing collected packages: jsonschema, functools32 05:58:51 INFO - Running setup.py install for functools32 05:58:51 INFO - warning: no files found matching '*.txt' 05:58:51 INFO - no previously-included directories found matching 'build' 05:58:51 INFO - no previously-included directories found matching 'dist' 05:58:51 INFO - no previously-included directories found matching '.git*' 05:58:51 INFO - Successfully installed jsonschema functools32 05:58:51 INFO - Cleaning up... 05:58:51 INFO - Return code: 0 05:58:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e50420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5b0577850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cdfe00>, '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 0x104b48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cdab20>, '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.KV8tjsGEfp/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.WZZal4SkcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 05:58: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', 'flake8'] in /builds/slave/test/build 05:58: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 flake8 05:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KV8tjsGEfp/Render', 05:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:51 INFO - 'HOME': '/Users/cltbld', 05:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:51 INFO - 'LOGNAME': 'cltbld', 05:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:51 INFO - 'MOZ_NO_REMOTE': '1', 05:58:51 INFO - 'NO_EM_RESTART': '1', 05:58:51 INFO - 'PAGER': '/bin/cat', 05:58:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:51 INFO - 'PWD': '/builds/slave/test', 05:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:51 INFO - 'SHELL': '/bin/bash', 05:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZZal4SkcK/Listeners', 05:58:51 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 05:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:51 INFO - 'USER': 'cltbld', 05:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:51 INFO - 'XPC_FLAGS': '0x0', 05:58:51 INFO - 'XPC_SERVICE_NAME': '0', 05:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:51 INFO - Downloading/unpacking flake8 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:58:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:58:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:58:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:55 INFO - no previously-included directories found matching 'docs/_build' 05:58:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:58:56 INFO - Running setup.py install for pep8 05:58:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:56 INFO - no previously-included directories found matching 'docs/_build' 05:58:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:58:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:58:56 INFO - Cleaning up... 05:58:56 INFO - Return code: 0 05:58:56 INFO - Running post-action listener: _resource_record_post_action 05:58:56 INFO - Running post-action listener: _start_resource_monitoring 05:58:56 INFO - Starting resource monitoring. 05:58:56 INFO - ##### 05:58:56 INFO - ##### Running install step. 05:58:56 INFO - ##### 05:58:56 INFO - Running pre-action listener: _resource_record_pre_action 05:58:56 INFO - Running main action method: install 05:58:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:56 INFO - Reading from file tmpfile_stdout 05:58:56 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:56 INFO - Reading from file tmpfile_stdout 05:58:56 INFO - Output received: 05:58:56 INFO - Usage: mozinstall [options] installer 05:58:56 INFO - Options: 05:58:56 INFO - -h, --help show this help message and exit 05:58:56 INFO - -d DEST, --destination=DEST 05:58:56 INFO - Directory to install application into. [default: 05:58:56 INFO - "/builds/slave/test"] 05:58:56 INFO - --app=APP Application being installed. [default: firefox] 05:58:56 INFO - mkdir: /builds/slave/test/build/application 05:58:56 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'] 05:58:56 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 05:59:18 INFO - Reading from file tmpfile_stdout 05:59:18 INFO - Output received: 05:59:18 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:59:18 INFO - Running post-action listener: _resource_record_post_action 05:59:18 INFO - ##### 05:59:18 INFO - ##### Running run-tests step. 05:59:18 INFO - ##### 05:59:18 INFO - Running pre-action listener: _resource_record_pre_action 05:59:18 INFO - Running main action method: run_tests 05:59:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:59:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:59:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:59:18 INFO - 2016-06-27 05:59:18.930 screenresolution[1998:12308] starting screenresolution argv=screenresolution get 05:59:18 INFO - 2016-06-27 05:59:18.933 screenresolution[1998:12308] Display 0: 1600x1200x32@60 05:59:18 INFO - 2016-06-27 05:59:18.939 screenresolution[1999:12310] starting screenresolution argv=screenresolution list 05:59:18 INFO - Available Modes on Display 0 05:59:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:59:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:59:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:59:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:59:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:59:19 INFO - Intel Iris: 05:59:19 INFO - Chipset Model: Intel Iris 05:59:19 INFO - Type: GPU 05:59:19 INFO - Bus: Built-In 05:59:19 INFO - VRAM (Dynamic, Max): 1536 MB 05:59:19 INFO - Vendor: Intel (0x8086) 05:59:19 INFO - Device ID: 0x0a2e 05:59:19 INFO - Revision ID: 0x0009 05:59:19 INFO - Displays: 05:59:19 INFO - Display: 05:59:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:59:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:59:19 INFO - Display Serial Number: 1600x1200 60 05:59:19 INFO - Main Display: Yes 05:59:19 INFO - Mirror: Off 05:59:19 INFO - Online: Yes 05:59:19 INFO - Rotation: Supported 05:59:19 INFO - Return code: 0 05:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:19 INFO - Python 2.7.3 05:59:19 INFO - Return code: 0 05:59:19 INFO - grabbing minidump binary from tooltool 05:59:19 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')]} 05:59:19 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 0x104cdfe00>, '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 0x104b48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cdab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:19 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 05:59:19 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 05:59:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:19 INFO - Return code: 0 05:59:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:59:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:59:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:59:20 INFO - Return code: 0 05:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0387 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KV8tjsGEfp/Render', 05:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:20 INFO - 'HOME': '/Users/cltbld', 05:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:20 INFO - 'LOGNAME': 'cltbld', 05:59:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:20 INFO - 'MOZ_NO_REMOTE': '1', 05:59:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:20 INFO - 'NO_EM_RESTART': '1', 05:59:20 INFO - 'PAGER': '/bin/cat', 05:59:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:20 INFO - 'PWD': '/builds/slave/test', 05:59:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:20 INFO - 'SHELL': '/bin/bash', 05:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZZal4SkcK/Listeners', 05:59:20 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 05:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:20 INFO - 'USER': 'cltbld', 05:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:20 INFO - 'XPC_FLAGS': '0x0', 05:59:20 INFO - 'XPC_SERVICE_NAME': '0', 05:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:59:20 INFO - mozversion application_buildid: 20160624143557 05:59:20 INFO - mozversion application_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 05:59:20 INFO - mozversion application_display_name: Firefox 05:59:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:20 INFO - mozversion application_name: Firefox 05:59:20 INFO - mozversion application_remotingname: firefox 05:59:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:59:20 INFO - mozversion application_vendor: Mozilla 05:59:20 INFO - mozversion application_version: 48.0 05:59:20 INFO - mozversion platform_buildid: 20160624143557 05:59:20 INFO - mozversion platform_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 05:59:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:59:20 INFO - mozversion platform_version: 48.0 05:59:20 INFO - using testdate: 1467032360 05:59:20 INFO - actual date: 1467032360 05:59:20 INFO - starting webserver on 'localhost:49406' 05:59:20 INFO - SUITE-START | Running 2 tests 05:59:20 INFO - TEST-START | dromaeo_css 05:59:20 INFO - operating with platform_type : mac_ 05:59:20 INFO - Initialising browser for dromaeo_css test... 05:59:20 INFO - TEST-INFO | started process 2017 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpwqZ66C/profile http://localhost:49406/getInfo.html) 05:59:22 INFO - PROCESS | 2017 | __metrics Screen width/height:1600/1200 05:59:22 INFO - PROCESS | 2017 | colorDepth:24 05:59:22 INFO - PROCESS | 2017 | Browser inner width/height: 1024/689 05:59:22 INFO - PROCESS | 2017 | __metrics 05:59:22 INFO - PROCESS | 2017 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:59:22 ERROR - PROCESS | 2017 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:59:23 INFO - TEST-INFO | 2017: exit 0 05:59:23 INFO - Browser initialized. 05:59:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:23 INFO - TEST-INFO | started process 2020 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpwqZ66C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:35 INFO - PROCESS | 2020 | RSS: Main: 161112064 05:59:35 INFO - PROCESS | 2020 | 06:00:26 INFO - PROCESS | 2020 | 1467032426670 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] 06:02:36 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49406/tests/dromaeo/cssquery-ext.html) 06:02:38 INFO - PROCESS | 2020 | RSS: Main: 298287104 06:02:38 INFO - PROCESS | 2020 | 06:05:41 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-ext.html (next: http://localhost:49406/tests/dromaeo/cssquery-jquery.html) 06:05:41 INFO - PROCESS | 2020 | RSS: Main: 307044352 06:05:41 INFO - PROCESS | 2020 | 06:08:43 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49406/tests/dromaeo/cssquery-mootools.html) 06:08:44 INFO - PROCESS | 2020 | RSS: Main: 307421184 06:08:44 INFO - PROCESS | 2020 | 06:11:46 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49406/tests/dromaeo/cssquery-prototype.html) 06:11:47 INFO - PROCESS | 2020 | RSS: Main: 307503104 06:11:47 INFO - PROCESS | 2020 | 06:14:50 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49406/tests/dromaeo/cssquery-yui.html) 06:14:50 INFO - PROCESS | 2020 | RSS: Main: 274612224 06:14:50 INFO - PROCESS | 2020 | 06:17:53 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-yui.html (next: http://localhost:49406/tests/dromaeo/cssquery-dojo.html) 06:17:53 INFO - PROCESS | 2020 | RSS: Main: 313192448 06:17:53 INFO - PROCESS | 2020 | 06:17:53 INFO - PROCESS | 2020 | __start_tp_report 06:17:53 INFO - PROCESS | 2020 | _x_x_mozilla_page_load 06:17:53 INFO - PROCESS | 2020 | _x_x_mozilla_page_load_details 06:17:53 INFO - PROCESS | 2020 | |i|pagename|runs| 06:17:53 INFO - PROCESS | 2020 | |0;dojo.html;3509.2279698466336;3523.0487768302573;3549.3078849624335;3572.8034958077305;3628.7097032237407;5768.451997060272;5773.307203135624;5783.739731712083;5806.854828629281;5857.560682948774;5755.366909639936;5796.913046304308;5799.2750906136735;5813.06990881458;5828.679422631753;5222.921656175151;5254.870202906374;5290.1800220965815;5305.867353316159;5352.732363381835;5306.204069389584;5364.624476286662;5378.354597448292;5385.272988146608;5393.78424863005;5338.119210330291;5355.705436201008;5380.650257733254;5395.757190926398;5399.7030163341;5385.084535628933;5394;5397.946020539823;5406.02691515527;5459.181122831567;5146.6911985281;5302.92045619316;5323.9884421959705;5336.626436149471;5341.225522299244;4683.2975053741875;5598.216249725042;5658.519025882805;5686.630369026;5701.77192912283;5380.569554435636;6225.252969643671;6234.376562343775;6241.500679945593;6248.625082495019;6223.408776166257;6249.468795152417;6281.340459251758;6292.433680968735;6296.779612713533;5928.140419639171;5948.405159484017;5955.52355811534;6003.549733769941;6009.609375390585;6233.096201050822;6243;6250.781222657185;6254.562180647311;6264.310925798159;6134.04922237054;6136.631802091889;6138.355472675394;6147.170132032208;6153.769246150788;6156.969215153896;6229.657368844666;6234.220722409699;6243.125962365272;6244.2506899171485;6211.937880621136;6239.844003899939;6243.906341404882;6247.625142491465;6271.623702577769;6207.6275423474735;6220.968895155495;6230.937690623126;6240.968795156086;6242.875142497215;4838.758062096881;4962.404511458648;4965.131102057126;5015.423226328946;5020.995800839773;4482.798274077609;4497.078098989699;4515.096980603892;4527.094581083797;4562.5665561771575;5842.182094506772;5863.237779088777;5865.530757539386;5866.2373891393845;5870;6172.69136543171;6237;6259.812205633838;6276.340984196685;6280.434760871543;4875.8049678012485;5839.678817665069;5840.59115861894;5854.970725146347;5865.090910908816;5049.444561098277;5268.815591454358;5430.104032834538;5497.725113744297;5542.778288868481;6312.368763123743;6376.872462550816;6400.911844986364;6447.968325067966;6468.644224567505;6273.278572964167;6278.623282602875;6279.905801413074;6288;6288.559800814082;6496.187976502937;6504.674766261763;6506.479481641552;6518.543701940818;6537.346265373425;6172.876542469216;6243.594166379171;6258.499320054476;6258.561900666909;6259.718312675849;5272.6309158358545;6197.845053873689;6239.625622462667;6247.531435142291;6259.092431597484;6123.862238009652;6151.477124444473;6212.0371342441995;6213.9067913982235;6217.844553886189;6176.258848938156;6176.4441200292185;6194.690265486798;6220.222472190976;6222.471089957405;5323.680579165262;6034.426729460694;6067.332593414632;6070.418453112685;6096.634201947897;6105.358937311696;6123.4961516426065;6192.628442293477;6218.409251121137;6222.253329600477;4638.466576343763;5958.463738263577;6048.485878700184;6077.11881777131;6119.244515559795 06:17:53 INFO - PROCESS | 2020 | |1;ext.html;529.748369524476;536.1930294906166;543.7634628936415;553.4216743503039;595.3272801734046;26300.47399052018;32564.0230793076;32749;38371.61628383715;39360.409593856115;42142;42687.57312426875;42734.78632606832;42738.57261427385;42761.35857962125;9621.518924053804;9863.802723945517;9879.06148915852;9881.209503239723;9888.653897113603;9168.449893006407;9634.566444510014;11776.116791240649;12062.974647154959;12082.033437325037;11690.532378704842;11762.294262344243;11765.882341176608;11779.469923853405;11789;11682.707932301675;11827.586034488751;11835.28388383688;11840.407979601072;11844.526218951274;11564;11629.651110466699;11643.417829108595;11672.708182295426;11676.649700508999;39294.60705392938;41258.793706031276;41388.37917431211;41429.792851035854;41441.96395090117;3283.917902052444;3351.8156501392414;3534.469829525566;3664;3887.280853042196;28616.856915715496;28619.57070643942;28668.283292917637;29846.40307193844;29918.401631967456;2801.8599070046416;2806.1862060002777;2810.269329974201;2884.120343295294;2900.463414268367;434479;521072.39463802817;526251.3687431577;526645;529653;36655.633443665756;37282.81358593189;37284.44073338902;61167;61566.38433615696;36430.453543196876;36489.08777280589;36538.26923461516;36544.817275913985;36637.450438243446;16119.516414507583;16264.837351626333;16267.51197464078;16288.185590720654;16294.185290735415;13021.544245951347;13044.739105217843;13698.52055178064;13803.447862085404;13825.446982120602;7901.565413902175;7993.520388776692;8305.626246818907;8520.360972926932;8532.36007299455;3412.283420481677;3471.3057388522398;3471.7916924984584;3476.28736109097;3510.578730552299;1013.3970287678819;1072.5066469424153;1127.4362818590705;1136.8067428537167;1154.2093665838927;29284.97502587399;29366.853165734035;29827.254318641775;29835.95574154894;29931;796.9123396426388;1129.5312445335258;1169.3042639629407;1177.988220117788;1206.8793120688038;13442.395092220873;15160.696786064216;15236.3905443781;15278.006929549543;15341.232938353038;635370;643518.7824060849;643958;644588;646715;58789.118163227584;60967.390326096174;61020;61035.38964610386;61463.385366146664;1406.3319923036477;1468.1924941282252;1504.8269449013503;1525.519461369665;1592.4506045414314;28864.278393040342;29108.417831643674;29593.816247349863;30102;30110.84944575351;46015;46119.3082103762;46398.76800615976;46523.534764653275;46567.767161163974;380663;386444.0677796593;387641;389496;620768;26686.86656566705;27496.58755118715;27500.449991000467;27514.862425687745;27515.17454476369;42101.36847947344;43676.781616091714;43939.56060439483;44028.119437610425;44559.33161002652;30136;35390.64609353874;36352.81823590865;36389.90830275096;37042;27995.86002070058;35571;36253.818730906176;37253.81373093117;37726.62273377231;37248;38254.808725956194;38447.423288651255;39165.82502524929;39710.823134148624;31207.687923120477;31490.685093148775;31752.841235793672;31908.5213721799;31936.840315798272;24084.39789005289;24324.635130472703;24374.51250975006;24827.627585586593;24887.253382398558 06:17:53 INFO - PROCESS | 2020 | |2;jquery.html;383.9805316883673;385.79167249685173;393.30974140383614;401.6184624606623;416.09084151129804;15972.600684982881;16025.679486410265;20405.897970510145;21136.89431552842;21147.99999999998;17322.480325590222;20617.175312987463;21204;21399.57200855982;22141.557168856652;4900.681455705386;4913.484084171164;5566.86082847929;5747.856303592402;5759.712014399284;4180.895477613054;4381.780910954455;4789.80840766369;6133.049377346519;6252.468540174091;3754.906127346811;4367.213901497729;4380.145871555048;5952.166696662471;6296.150019747344;5151.948480515184;5339.439358867321;6203.751849925998;6255.218097737783;6273.3726627337355;6137.6624285664275;6171.321154672983;6172.567920245585;6181.3818618138275;6182.783602573933;13743.244121573309;14375;14380.496682616164;14419.35112919921;14530.491432799907;2283.4291427143216;2367.8342516023886;2448.461338505526;2448.7306396296394;2809.9157025289273;10237.692869213935;10549.103326217204;10761;10957.671269861918;12367.443465044005;1780.9554761130946;1819.6198596236422;1873.653374125791;1910.3695780392436;2070.6997485364536;85000;119105.40447297708;122419.38790306081;123716.38141809234;123856;11806.232594881305;11819.349935753617;12118.151729379035;12164.939175304067;12229.082818788627;15828.60428489297;15900.68198636044;15945.123018233877;15957.601059973362;15964.521064367855;8578.056413794478;9026.593803278869;9291.767705807273;9376.578053987587;9473.478958657202;9177.128172823572;9214.63141474347;9350;9413;9503.287253455881;4845.75771211438;4920.794405370707;4945.109880221595;4946.738581661725;4964.851054468371;2045.4681782736595;2045.7954204579423;2050.7846676098793;2076.6884967255032;2119.777423370524;817.5789468423767;855.897292324925;957.6935380678116;960.4429430930044;1029.0275689473376;20903.37289881306;21750.803705796017;21804.890975545022;21873.343799686034;21957.451063723536;999.2256001598819;1036.7200855769051;1044.4046893270915;1073.9904489779583;1083.4311986207147;11288.830667539993;11522.423878806027;11543.307401555934;11556.959873611415;11695.649130526097;597011;597876;603542;605594;613944;82491.3501729962;130132;131394;131444;133738.33130834284;971.2958105373548;1018.7367664096615;1036.7554245059512;1040.266612038511;1061.2412125330425;15295.694086118438;15887.761683574525;18578.163982620543;18911.621767564848;19482.4155275342;53063.2243098123;54413.18380224379;54577;54684;55167.72416137894;76622;78953;79954.60022699849;80233;82429;8278.668853245803;8547.82904341922;8626.223639872442;8781.121887811169;8824.514651694219;9583.712488625353;12730.745385092061;12987.675308117372;13013;13252.469901203844;10390.896091038992;10869.967353101443;11081.390523521284;11419.200655954335;11651;11107.611233606785;11210.887891120985;11259.268147570381;11482.679491858544;11528.654140375467;11493.425328733363;11546.59586914454;11759.647210583697;11951.820722688994;12116.030717542399;8137.226963438464;8388.496690198608;8410.327173826201;8669.263112635497;8858.557072146496;8477.74566762998;9469.384490008128;9604.471754053595;10470.371777693363;11577.479013444583 06:17:53 INFO - PROCESS | 2020 | |3;mootools.html;1473.2118316700567;1592.0765955745665;1619.4736710569064;1897;2015.3953813855849;8259.669613215472;8903.287736981043;9062.320325975545;9076.22852057576;9082.273418126551;8740.300775937925;9016.09839016098;9036.8644470333;9049.2308153807;9052.683156089539;2564.3204550794053;2592.44262483566;2594.7924166066764;2594.8572828494425;2596.8961241550314;2523.1547431610434;2578.8323758955703;2581.9612705809427;2583.3799888026924;2591.883365248568;2562.5387430262545;2584.1859814158574;2597.870106494677;2600.1809430029575;2602.2193341997418;2499.4751102268547;2524.1291754344907;2528.3426309159568;2579.9871000645066;2592.2482480080753;2463.581191197483;2491.638712386712;2507.962380564293;2586.3275548357565;2588.327034970921;8893;9184.494852783095;9246.214071803837;9249.953750231272;9253.814923701555;5687.630304030266;5781.4507621775865;5783.045797443417;5797.449242321973;5870.354261031283;3649.251903359805;3717.8512859485586;3776.395776675746;3785.0915780212827;3793.4499497572697;1036.259074761549;1047.0576481166934;1047.8899715529913;1058.8094143054248;1081.9505080072395;12235.204711693801;12327.952124069465;12477.688057798629;12601.432935517923;12608.74782504354;4030.1939612077704;4761.952380476151;4880.926786098212;4888.853334399973;4900.534449227318;9701.757456063513;9716.02839716037;9728.513574321256;9733.951330243304;9740.074692904163;4856.68431551948;5606.6636001840025;5666.603337766399;5677.318721753416;5679.772809087673;4660.790264438108;4761.904761904742;4817.807287708522;4825.638077144228;5232.1628539433505;3940.6650434712797;4301.161273551627;4308.116836048603;4332.718373305725;4338.327559228324;1387.1053170704838;1403.929803509841;1415.7168566286578;1422.7225690990365;1431.119861285323;872.7774417523491;950.8431108867098;962.1244667352676;964.6864768950119;981.3817295104182;6035.939640603626;6168.35232300602;6194.225721784777;6208.72060757267;6234.3453937336835;957.8898426680881;1003.7340104872214;1010.6412223660642;1015.6394479959656;1039.679606899249;4041.9595804041583;4104.8152833122585;4113.403556484293;4160.18876319121;4166.729162604421;10655.84016239757;11008.449577521253;11022.393768342657;11167.553297868157;11178.105751539857;10903.236773425784;10960.451977401099;10984.835227471594;10987.121030317556;11077.446127693584;8189.50862948225;8413.789655258668;8452.112528184574;8516.74449766508;8623.267022303175;6068.6358818471035;6102.809952059306;6158.784442544489;6165.5375846810775;6217.906731399123;9660.130588247092;9710.514474276399;9816.2147028239;9834.262430317613;9867.457289849128;9577.616895324109;10042.49787510636;10053.19574434058;10264.538095785856;10264.897351026395;6995.405390541861;7186.10173728284;7188.676509556978;7683.270089341504;7903.84192316162;8167.714130005421;8679.739607811776;8695.826083478421;8696.260817830555;8713.215810577078;7534.736284230245;7683.9231607683205;7738.41961852852;7786.26030527099;7829;7544.132424771002;7581.848363032819;7609.6575654094595;7733.149353570991;7752.186020467995;7249.565026098451;7301.707931682673;7322.304381083789;7383.963080184565;7406.7037318506655;4968.950310496849;5022.547970682656;5052;5152.742362881766;5173.430922598586;5021.548060674557;5087.287779710769;5150.381954165524;5185.896282074413;5238.580913526985 06:17:53 INFO - PROCESS | 2020 | |4;prototype.html;334.01965232043943;340.05295252721174;346.0794287196058;348.93544694231554;352.67377675650016;6892.758753443624;6894;6900.275471075527;6921.65391730414;6935.9653201734045;6697.631630260334;6808.523403361766;6948.478864085201;6959.8956015659805;6960.860782784354;4907.779149938261;5025.974870125644;5061.797528098871;5099.133147364938;5135.972805438909;5093.79624815007;5198.246254293125;5201.349831271091;5210.5310522053005;5219.973900130494;5131;5134.589232861381;5136.409312929005;5139.203423469368;5147.4080480744815;4876.390451193601;4967.801287948478;5053;5055.140626093536;5060.342155519796;4306.569343065699;4322.978385108055;4329.285667864799;4330.675199360029;4339.305711086211;6593.86812263752;6701.899471507932;6729.461643068543;6782.966085169592;6874.931250687529;6059.182480146709;6079.331273559905;6083.057126145454;6084.574079814415;6096.72564734588;7171.784846454615;7406.925930740731;7412.295831895961;7421.703131874719;7446.218147094532;4894.583960363338;4938.851834444972;4946.5795407390415;4952.306677065214;4967.602591792648;7799.181085985946;7802.531848089133;7810.687572497093;7812.726554570563;7822.452428330019;5001.874953126201;5013.1227035268685;5015.623828212899;5024.79900803971;5030.773615187325;5098.796048158032;5101;5108.897822043538;5118.411382690963;5126.128558145124;5858.384869588717;6065.423784740443;6073.726682299307;6082.543809214327;6089.908651370233;7378.077740282465;7418.369438597671;7426.257374262531;7429.368503677248;7451.552906825499;1748.9562760931078;1779.6885545029568;1781.536800431897;1782.3761683410962;1783.9643207135784;1063.3407287481657;1079.740862193068;1117.8379135025375;1138.1179585821055;1159.878212787662;5569.777208911679;6789.558678685869;6791.388775010174;6865.691043903036;6939.271376505394;6273.560850740404;7804.726834560876;7808.960955195188;7809.843803123906;7810.258025487683;6180.825643127791;6669.7665581704405;7087.1849737279845;7099.716011359591;7103.325184107502;3974.125692347679;4069.023434375788;4128.91742165161;4129.710920235615;4132.40080188371;6357.855585994565;8087.110417854032;8129.837403251902;8150.307223885918;8155.836883262302;6437.613743175424;8036.517808931483;8051.194880511902;8051.355891528664;8056.516609003478;6153.38466153399;8111.18888111196;8155.592220389076;8158.469699469515;8172.877406838902;7426.554406735613;7681.116671582839;7692.42306826979;7750.031246094239;7768.262015108556;7588.734394296394;7622.9237707622215;7641.694332226649;7647.770566883002;7653.272939070779;8136.308413784895;8144.511329320259;8150.592470376576;8151;8159.959200203961;4397.890052748707;4542.954570454385;4822.987172693774;4885.706857588556;4890.486498917562;7487.438442116754;7743.264389882952;7764.88352674699;7765.495242809199;7778.727744529141;6095.969520152371;7431.29402706742;7454.813629659302;7488.625568721651;7500.624968751432;7463.731165701953;7467.925320746723;7479.700811967678;7482.551046937201;7492.213317601573;6993.895091573732;7298.087739032621;7299.781006569811;7301.963490182515;7312.1591017033725;7379.926200737924;7468.887966680612;7500.399968002437;7501.174870764321;7532.0208372911175;7041.894371584328;7163.820904477429;7201.243869393638;7353.264673532604;7364.705411783469 06:17:53 INFO - PROCESS | 2020 | |5;yui.html;696.9477289203311;714.9177844547877;764.8623247815391;792.1959211400426;792.615581443;15347.3093710783;15566.299516521756;15568.68862622747;15593;15614;11960.581379651714;13889.30553472325;14375.856241437583;14384.71230575388;14389.496367627135;751.7631945937026;778.5873487051844;932.1889955738517;961.4663861556833;963.5037955452947;937.0535758883543;947.497826152137;950.4202436513721;950.6292545907102;952.6903756279203;808.9797755056112;999.7200783780517;1000.4697510319506;1002.904724051214;1003.0120331473493;984.6406061787468;1010.2322235101376;1012.4330374989955;1012.549415510091;1014.6093753904726;750.7072241825692;750.962451877404;751.0724255544399;751.7970148060048;753.0473950452682;12502.312372819491;15293.541193764206;15300.08199508033;15305.61735956599;15308;13068;13173.473061077546;13272.203667779868;13296.72465255796;13367.933160334136;9957.701268961942;10025.19798416125;10069.949650251701;10331.845022324596;10694.839577406266;3570.0896271450615;3587.7667951583326;3610.891673249807;3661.0664280608275;3835.635614616635;72797;87611;88804.5559772197;90805;90945.54527227322;9719.951400242953;9821.754456138653;9841.753956151153;9878.555465004092;9930.354526955725;22923.885380573323;22947.885260573592;22952;22962.081516739476;22962.311130665774;7643.656035478306;7645.273698998586;7715.22847715224;7715.768526944201;7931.722389716448;3604.225091605265;4278.4865816102265;4350.412694286294;4374.5625437456;4428.269335559597;3728.2357116790995;3781.5273090863643;3788.1476667749534;3793.7534060285993;3799.3351163546267;532.1884126706726;614.1095411653121;635.6948664640998;653.3140202787055;658.5949640970864;495.7694671977476;529.6530772344121;548.8134034428314;553.6788662575697;609.460627344803;7881.408894332948;8301.46040507365;8370.372222083246;8411.831763364698;8585.835959161592;539.6384422436977;557.8410153106427;572.899742545053;576.5646936562869;628.1206311164407;3812.6187381262207;3989.68082553395;4022.8994275143355;4049.149678567534;4190.685698572619;87933.56033219793;89051;90437.64343534852;90563.18873622491;91257;56034;71969.92045119328;72480.63759681168;72929;73017.90473142907;65974;66753.33246667568;70859;71054.93417598741;72678.63660681662;8528.232459078712;8587.22714955632;8659.696910608098;8877.600507977286;8905.109489051301;47613.42494976751;48612;49192.26211606757;50382;51431.74284128555;64186;64746.35253647592;65427.345726542124;66354.00468992873;66374.66812665906;10825.404602746925;11157;11216.214864959375;11295.3787541686;11490.77018459643;11428.714282143013;12150.817737733763;12163.574274900337;12356.135070544975;12551.184173028723;11493.942530287295;11663.475143618387;11696.70758231051;11697.590584329508;12129.332886691316;11195.944020279847;11546.107588504432;11564.537418503165;11598.420078996185;12095.911367976923;11232.382218978035;11323.433828308716;11351.14866385008;11659.125565582446;11692.298462092302;9687.903120968982;9865.309428339948;10071.295009349275;10109;10407.58369665205;9975.800483990424;10174.898251017396;10183;10215;10228.897711022795 06:17:53 INFO - PROCESS | 2020 | __end_tp_report 06:17:53 INFO - PROCESS | 2020 | __start_cc_report 06:17:53 INFO - PROCESS | 2020 | _x_x_mozilla_cycle_collect,1185 06:17:53 INFO - PROCESS | 2020 | __end_cc_report 06:17:53 INFO - PROCESS | 2020 | __startTimestamp1467033473654__endTimestamp 06:17:53 INFO - PROCESS | 2020 | 06:17:53 INFO - PROCESS | 2020 | ------- Summary: start ------- 06:17:53 INFO - PROCESS | 2020 | Number of tests: 6 06:17:53 INFO - PROCESS | 2020 | 06:17:53 INFO - PROCESS | 2020 | [#0] dojo.html Cycles:165 Average:5789.30 Median:6067.33 stddev:629.91 (10.4%) stddev-sans-first:605.91 06:17:53 INFO - PROCESS | 2020 | Values: 3509.2 3523.0 3549.3 3572.8 3628.7 5768.5 5773.3 5783.7 5806.9 5857.6 5755.4 5796.9 5799.3 5813.1 5828.7 5222.9 5254.9 5290.2 5305.9 5352.7 5306.2 5364.6 5378.4 5385.3 5393.8 5338.1 5355.7 5380.7 5395.8 5399.7 5385.1 5394.0 5397.9 5406.0 5459.2 5146.7 5302.9 5324.0 5336.6 5341.2 4683.3 5598.2 5658.5 5686.6 5701.8 5380.6 6225.3 6234.4 6241.5 6248.6 6223.4 6249.5 6281.3 6292.4 6296.8 5928.1 5948.4 5955.5 6003.5 6009.6 6233.1 6243.0 6250.8 6254.6 6264.3 6134.0 6136.6 6138.4 6147.2 6153.8 6157.0 6229.7 6234.2 6243.1 6244.3 6211.9 6239.8 6243.9 6247.6 6271.6 6207.6 6221.0 6230.9 6241.0 6242.9 4838.8 4962.4 4965.1 5015.4 5021.0 4482.8 4497.1 4515.1 4527.1 4562.6 5842.2 5863.2 5865.5 5866.2 5870.0 6172.7 6237.0 6259.8 6276.3 6280.4 4875.8 5839.7 5840.6 5855.0 5865.1 5049.4 5268.8 5430.1 5497.7 5542.8 6312.4 6376.9 6400.9 6448.0 6468.6 6273.3 6278.6 6279.9 6288.0 6288.6 6496.2 6504.7 6506.5 6518.5 6537.3 6172.9 6243.6 6258.5 6258.6 6259.7 5272.6 6197.8 6239.6 6247.5 6259.1 6123.9 6151.5 6212.0 6213.9 6217.8 6176.3 6176.4 6194.7 6220.2 6222.5 5323.7 6034.4 6067.3 6070.4 6096.6 6105.4 6123.5 6192.6 6218.4 6222.3 4638.5 5958.5 6048.5 6077.1 6119.2 06:17:53 INFO - PROCESS | 2020 | 06:17:53 INFO - PROCESS | 2020 | [#1] ext.html Cycles:180 Average:64950.78 Median:3471.55 stddev:144071.97 (4150.1%) stddev-sans-first:144394.94 06:17:53 INFO - PROCESS | 2020 | Values: 529.7 536.2 543.8 553.4 595.3 26300.5 32564.0 32749.0 38371.6 39360.4 42142.0 42687.6 42734.8 42738.6 42761.4 9621.5 9863.8 9879.1 9881.2 9888.7 9168.4 9634.6 11776.1 12063.0 12082.0 11690.5 11762.3 11765.9 11779.5 11789.0 11682.7 11827.6 11835.3 11840.4 11844.5 11564.0 11629.7 11643.4 11672.7 11676.6 39294.6 41258.8 41388.4 41429.8 41442.0 3283.9 3351.8 3534.5 3664.0 3887.3 28616.9 28619.6 28668.3 29846.4 29918.4 2801.9 2806.2 2810.3 2884.1 2900.5 434479.0 521072.4 526251.4 526645.0 529653.0 36655.6 37282.8 37284.4 61167.0 61566.4 36430.5 36489.1 36538.3 36544.8 36637.5 16119.5 16264.8 16267.5 16288.2 16294.2 13021.5 13044.7 13698.5 13803.4 13825.4 7901.6 7993.5 8305.6 8520.4 8532.4 3412.3 3471.3 3471.8 3476.3 3510.6 1013.4 1072.5 1127.4 1136.8 1154.2 29285.0 29366.9 29827.3 29836.0 29931.0 796.9 1129.5 1169.3 1178.0 1206.9 13442.4 15160.7 15236.4 15278.0 15341.2 635370.0 643518.8 643958.0 644588.0 646715.0 58789.1 60967.4 61020.0 61035.4 61463.4 1406.3 1468.2 1504.8 1525.5 1592.5 28864.3 29108.4 29593.8 30102.0 30110.8 46015.0 46119.3 46398.8 46523.5 46567.8 380663.0 386444.1 387641.0 389496.0 620768.0 26686.9 27496.6 27500.4 27514.9 27515.2 42101.4 43676.8 43939.6 44028.1 44559.3 30136.0 35390.6 36352.8 36389.9 37042.0 27995.9 35571.0 36253.8 37253.8 37726.6 37248.0 38254.8 38447.4 39165.8 39710.8 31207.7 31490.7 31752.8 31908.5 31936.8 24084.4 24324.6 24374.5 24827.6 24887.3 06:17:53 INFO - PROCESS | 2020 | 06:17:53 INFO - PROCESS | 2020 | [#2] jquery.html Cycles:180 Average:34777.75 Median:21915.40 stddev:100605.77 (459.1%) stddev-sans-first:100854.85 06:17:53 INFO - PROCESS | 2020 | Values: 384.0 385.8 393.3 401.6 416.1 15972.6 16025.7 20405.9 21136.9 21148.0 17322.5 20617.2 21204.0 21399.6 22141.6 4900.7 4913.5 5566.9 5747.9 5759.7 4180.9 4381.8 4789.8 6133.0 6252.5 3754.9 4367.2 4380.1 5952.2 6296.2 5151.9 5339.4 6203.8 6255.2 6273.4 6137.7 6171.3 6172.6 6181.4 6182.8 13743.2 14375.0 14380.5 14419.4 14530.5 2283.4 2367.8 2448.5 2448.7 2809.9 10237.7 10549.1 10761.0 10957.7 12367.4 1781.0 1819.6 1873.7 1910.4 2070.7 85000.0 119105.4 122419.4 123716.4 123856.0 11806.2 11819.3 12118.2 12164.9 12229.1 15828.6 15900.7 15945.1 15957.6 15964.5 8578.1 9026.6 9291.8 9376.6 9473.5 9177.1 9214.6 9350.0 9413.0 9503.3 4845.8 4920.8 4945.1 4946.7 4964.9 2045.5 2045.8 2050.8 2076.7 2119.8 817.6 855.9 957.7 960.4 1029.0 20903.4 21750.8 21804.9 21873.3 21957.5 999.2 1036.7 1044.4 1074.0 1083.4 11288.8 11522.4 11543.3 11557.0 11695.6 597011.0 597876.0 603542.0 605594.0 613944.0 82491.4 130132.0 131394.0 131444.0 133738.3 971.3 1018.7 1036.8 1040.3 1061.2 15295.7 15887.8 18578.2 18911.6 19482.4 53063.2 54413.2 54577.0 54684.0 55167.7 76622.0 78953.0 79954.6 80233.0 82429.0 8278.7 8547.8 8626.2 8781.1 8824.5 9583.7 12730.7 12987.7 13013.0 13252.5 10390.9 10870.0 11081.4 11419.2 11651.0 11107.6 11210.9 11259.3 11482.7 11528.7 11493.4 11546.6 11759.6 11951.8 12116.0 8137.2 8388.5 8410.3 8669.3 8858.6 8477.7 9469.4 9604.5 10470.4 11577.5 06:17:53 INFO - PROCESS | 2020 | 06:17:53 INFO - PROCESS | 2020 | [#3] mootools.html Cycles:180 Average:5903.80 Median:5037.27 stddev:3239.27 (64.3%) stddev-sans-first:3231.24 06:17:53 INFO - PROCESS | 2020 | Values: 1473.2 1592.1 1619.5 1897.0 2015.4 8259.7 8903.3 9062.3 9076.2 9082.3 8740.3 9016.1 9036.9 9049.2 9052.7 2564.3 2592.4 2594.8 2594.9 2596.9 2523.2 2578.8 2582.0 2583.4 2591.9 2562.5 2584.2 2597.9 2600.2 2602.2 2499.5 2524.1 2528.3 2580.0 2592.2 2463.6 2491.6 2508.0 2586.3 2588.3 8893.0 9184.5 9246.2 9250.0 9253.8 5687.6 5781.5 5783.0 5797.4 5870.4 3649.3 3717.9 3776.4 3785.1 3793.4 1036.3 1047.1 1047.9 1058.8 1082.0 12235.2 12328.0 12477.7 12601.4 12608.7 4030.2 4762.0 4880.9 4888.9 4900.5 9701.8 9716.0 9728.5 9734.0 9740.1 4856.7 5606.7 5666.6 5677.3 5679.8 4660.8 4761.9 4817.8 4825.6 5232.2 3940.7 4301.2 4308.1 4332.7 4338.3 1387.1 1403.9 1415.7 1422.7 1431.1 872.8 950.8 962.1 964.7 981.4 6035.9 6168.4 6194.2 6208.7 6234.3 957.9 1003.7 1010.6 1015.6 1039.7 4042.0 4104.8 4113.4 4160.2 4166.7 10655.8 11008.4 11022.4 11167.6 11178.1 10903.2 10960.5 10984.8 10987.1 11077.4 8189.5 8413.8 8452.1 8516.7 8623.3 6068.6 6102.8 6158.8 6165.5 6217.9 9660.1 9710.5 9816.2 9834.3 9867.5 9577.6 10042.5 10053.2 10264.5 10264.9 6995.4 7186.1 7188.7 7683.3 7903.8 8167.7 8679.7 8695.8 8696.3 8713.2 7534.7 7683.9 7738.4 7786.3 7829.0 7544.1 7581.8 7609.7 7733.1 7752.2 7249.6 7301.7 7322.3 7384.0 7406.7 4969.0 5022.5 5052.0 5152.7 5173.4 5021.5 5087.3 5150.4 5185.9 5238.6 06:17:53 INFO - PROCESS | 2020 | 06:17:53 INFO - PROCESS | 2020 | [#4] prototype.html Cycles:180 Average:6082.43 Median:6837.11 stddev:1936.12 (28.3%) stddev-sans-first:1892.87 06:17:53 INFO - PROCESS | 2020 | Values: 334.0 340.1 346.1 348.9 352.7 6892.8 6894.0 6900.3 6921.7 6936.0 6697.6 6808.5 6948.5 6959.9 6960.9 4907.8 5026.0 5061.8 5099.1 5136.0 5093.8 5198.2 5201.3 5210.5 5220.0 5131.0 5134.6 5136.4 5139.2 5147.4 4876.4 4967.8 5053.0 5055.1 5060.3 4306.6 4323.0 4329.3 4330.7 4339.3 6593.9 6701.9 6729.5 6783.0 6874.9 6059.2 6079.3 6083.1 6084.6 6096.7 7171.8 7406.9 7412.3 7421.7 7446.2 4894.6 4938.9 4946.6 4952.3 4967.6 7799.2 7802.5 7810.7 7812.7 7822.5 5001.9 5013.1 5015.6 5024.8 5030.8 5098.8 5101.0 5108.9 5118.4 5126.1 5858.4 6065.4 6073.7 6082.5 6089.9 7378.1 7418.4 7426.3 7429.4 7451.6 1749.0 1779.7 1781.5 1782.4 1784.0 1063.3 1079.7 1117.8 1138.1 1159.9 5569.8 6789.6 6791.4 6865.7 6939.3 6273.6 7804.7 7809.0 7809.8 7810.3 6180.8 6669.8 7087.2 7099.7 7103.3 3974.1 4069.0 4128.9 4129.7 4132.4 6357.9 8087.1 8129.8 8150.3 8155.8 6437.6 8036.5 8051.2 8051.4 8056.5 6153.4 8111.2 8155.6 8158.5 8172.9 7426.6 7681.1 7692.4 7750.0 7768.3 7588.7 7622.9 7641.7 7647.8 7653.3 8136.3 8144.5 8150.6 8151.0 8160.0 4397.9 4543.0 4823.0 4885.7 4890.5 7487.4 7743.3 7764.9 7765.5 7778.7 6096.0 7431.3 7454.8 7488.6 7500.6 7463.7 7467.9 7479.7 7482.6 7492.2 6993.9 7298.1 7299.8 7302.0 7312.2 7379.9 7468.9 7500.4 7501.2 7532.0 7041.9 7163.8 7201.2 7353.3 7364.7 06:17:53 INFO - PROCESS | 2020 | 06:17:53 INFO - PROCESS | 2020 | [#5] yui.html Cycles:180 Average:18214.37 Median:24844.02 stddev:25190.13 (101.4%) stddev-sans-first:25226.46 06:17:53 INFO - PROCESS | 2020 | Values: 696.9 714.9 764.9 792.2 792.6 15347.3 15566.3 15568.7 15593.0 15614.0 11960.6 13889.3 14375.9 14384.7 14389.5 751.8 778.6 932.2 961.5 963.5 937.1 947.5 950.4 950.6 952.7 809.0 999.7 1000.5 1002.9 1003.0 984.6 1010.2 1012.4 1012.5 1014.6 750.7 751.0 751.1 751.8 753.0 12502.3 15293.5 15300.1 15305.6 15308.0 13068.0 13173.5 13272.2 13296.7 13367.9 9957.7 10025.2 10069.9 10331.8 10694.8 3570.1 3587.8 3610.9 3661.1 3835.6 72797.0 87611.0 88804.6 90805.0 90945.5 9720.0 9821.8 9841.8 9878.6 9930.4 22923.9 22947.9 22952.0 22962.1 22962.3 7643.7 7645.3 7715.2 7715.8 7931.7 3604.2 4278.5 4350.4 4374.6 4428.3 3728.2 3781.5 3788.1 3793.8 3799.3 532.2 614.1 635.7 653.3 658.6 495.8 529.7 548.8 553.7 609.5 7881.4 8301.5 8370.4 8411.8 8585.8 539.6 557.8 572.9 576.6 628.1 3812.6 3989.7 4022.9 4049.1 4190.7 87933.6 89051.0 90437.6 90563.2 91257.0 56034.0 71969.9 72480.6 72929.0 73017.9 65974.0 66753.3 70859.0 71054.9 72678.6 8528.2 8587.2 8659.7 8877.6 8905.1 47613.4 48612.0 49192.3 50382.0 51431.7 64186.0 64746.4 65427.3 66354.0 66374.7 10825.4 11157.0 11216.2 11295.4 11490.8 11428.7 12150.8 12163.6 12356.1 12551.2 11493.9 11663.5 11696.7 11697.6 12129.3 11195.9 11546.1 11564.5 11598.4 12095.9 11232.4 11323.4 11351.1 11659.1 11692.3 9687.9 9865.3 10071.3 10109.0 10407.6 9975.8 10174.9 10183.0 10215.0 10228.9 06:17:53 INFO - PROCESS | 2020 | -------- Summary: end -------- 06:17:53 INFO - PROCESS | 2020 | 06:17:54 INFO - TEST-INFO | 2020: exit 0 06:17:54 INFO - TEST-OK | dromaeo_css | took 1113678ms 06:17:54 INFO - TEST-START | kraken 06:17:54 INFO - operating with platform_type : mac_ 06:17:54 INFO - Initialising browser for kraken test... 06:17:54 INFO - TEST-INFO | started process 2022 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmp29My_o/profile http://localhost:49406/getInfo.html) 06:17:56 INFO - PROCESS | 2022 | __metrics Screen width/height:1600/1200 06:17:56 INFO - PROCESS | 2022 | colorDepth:24 06:17:56 INFO - PROCESS | 2022 | Browser inner width/height: 1024/689 06:17:56 INFO - PROCESS | 2022 | __metrics 06:17:56 INFO - PROCESS | 2022 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:17:56 ERROR - PROCESS | 2022 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:17:57 INFO - TEST-INFO | 2022: exit 0 06:17:57 INFO - Browser initialized. 06:17:57 INFO - Running cycle 1/1 for kraken test... 06:17:57 INFO - TEST-INFO | started process 2025 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmp29My_o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:08 INFO - PROCESS | 2025 | RSS: Main: 161144832 06:18:08 INFO - PROCESS | 2025 | 06:18:11 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49406/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:12 INFO - PROCESS | 2025 | RSS: Main: 223424512 06:18:12 INFO - PROCESS | 2025 | 06:18:15 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49406/tests/kraken/driver.html?testName=audio-dft) 06:18:15 INFO - PROCESS | 2025 | RSS: Main: 239591424 06:18:15 INFO - PROCESS | 2025 | 06:18:19 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49406/tests/kraken/driver.html?testName=audio-fft) 06:18:19 INFO - PROCESS | 2025 | RSS: Main: 325922816 06:18:19 INFO - PROCESS | 2025 | 06:18:21 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49406/tests/kraken/driver.html?testName=audio-oscillator) 06:18:22 INFO - PROCESS | 2025 | RSS: Main: 230395904 06:18:22 INFO - PROCESS | 2025 | 06:18:24 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49406/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:25 INFO - PROCESS | 2025 | RSS: Main: 232493056 06:18:25 INFO - PROCESS | 2025 | 06:18:27 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49406/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:28 INFO - PROCESS | 2025 | RSS: Main: 269721600 06:18:28 INFO - PROCESS | 2025 | 06:18:31 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49406/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:31 INFO - PROCESS | 2025 | RSS: Main: 270188544 06:18:31 INFO - PROCESS | 2025 | 06:18:34 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49406/tests/kraken/driver.html?testName=json-parse-financial) 06:18:35 INFO - PROCESS | 2025 | RSS: Main: 268259328 06:18:35 INFO - PROCESS | 2025 | 06:18:36 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49406/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:37 INFO - PROCESS | 2025 | RSS: Main: 260386816 06:18:37 INFO - PROCESS | 2025 | 06:18:39 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:40 INFO - PROCESS | 2025 | RSS: Main: 268120064 06:18:40 INFO - PROCESS | 2025 | 06:18:42 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:42 INFO - PROCESS | 2025 | RSS: Main: 270700544 06:18:42 INFO - PROCESS | 2025 | 06:18:45 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:46 INFO - PROCESS | 2025 | RSS: Main: 277749760 06:18:46 INFO - PROCESS | 2025 | 06:18:48 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:49 INFO - PROCESS | 2025 | RSS: Main: 274747392 06:18:49 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49406/tests/kraken/driver.html?testName=ai-astar) 06:18:51 INFO - PROCESS | 2025 | RSS: Main: 335855616 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | __start_tp_report 06:18:51 INFO - PROCESS | 2025 | _x_x_mozilla_page_load 06:18:51 INFO - PROCESS | 2025 | _x_x_mozilla_page_load_details 06:18:51 INFO - PROCESS | 2025 | |i|pagename|runs| 06:18:51 INFO - PROCESS | 2025 | |0;ai-astar;114;115;117;114;118;162;167;132;114;132 06:18:51 INFO - PROCESS | 2025 | |1;audio-beat-detection;159;120;146;163;116;141;141;117;168;119 06:18:51 INFO - PROCESS | 2025 | |2;audio-dft;185;185;188;184;187;184;182;186;185;186 06:18:51 INFO - PROCESS | 2025 | |3;audio-fft;72;78;74;153;57;56;58;65;133;55 06:18:51 INFO - PROCESS | 2025 | |4;audio-oscillator;92;92;145;79;78;82;126;80;96;165 06:18:51 INFO - PROCESS | 2025 | |5;imaging-gaussian-blur;89;87;90;87;130;87;91;88;89;86 06:18:51 INFO - PROCESS | 2025 | |6;imaging-darkroom;94;95;95;96;94;95;96;95;94;95 06:18:51 INFO - PROCESS | 2025 | |7;imaging-desaturate;86;84;84;85;86;82;84;106;134;74 06:18:51 INFO - PROCESS | 2025 | |8;json-parse-financial;60;64;62;62;61;62;61;77;58;56 06:18:51 INFO - PROCESS | 2025 | |9;json-stringify-tinderbox;60;64;61;68;68;72;67;65;65;67 06:18:51 INFO - PROCESS | 2025 | |10;stanford-crypto-aes;79;80;79;80;79;78;80;79;80;82 06:18:51 INFO - PROCESS | 2025 | |11;stanford-crypto-ccm;127;126;140;139;143;139;126;123;143;128 06:18:51 INFO - PROCESS | 2025 | |12;stanford-crypto-pbkdf2;162;163;164;169;163;160;163;162;163;167 06:18:51 INFO - PROCESS | 2025 | |13;stanford-crypto-sha256-iterative;67;68;68;66;66;66;65;67;70;65 06:18:51 INFO - PROCESS | 2025 | __end_tp_report 06:18:51 INFO - PROCESS | 2025 | __start_cc_report 06:18:51 INFO - PROCESS | 2025 | _x_x_mozilla_cycle_collect,1923 06:18:51 INFO - PROCESS | 2025 | __end_cc_report 06:18:51 INFO - PROCESS | 2025 | __startTimestamp1467033531437__endTimestamp 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | ------- Summary: start ------- 06:18:51 INFO - PROCESS | 2025 | Number of tests: 14 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#0] ai-astar Cycles:10 Average:128.50 Median:125.00 stddev:20.23 (16.2%) stddev-sans-first:20.77 06:18:51 INFO - PROCESS | 2025 | Values: 114.0 115.0 117.0 114.0 118.0 162.0 167.0 132.0 114.0 132.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:143.50 stddev:20.13 (14.0%) stddev-sans-first:20.01 06:18:51 INFO - PROCESS | 2025 | Values: 159.0 120.0 146.0 163.0 116.0 141.0 141.0 117.0 168.0 119.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.50 stddev:1.69 (0.9%) stddev-sans-first:1.79 06:18:51 INFO - PROCESS | 2025 | Values: 185.0 185.0 188.0 184.0 187.0 184.0 182.0 186.0 185.0 186.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#3] audio-fft Cycles:10 Average:80.10 Median:61.50 stddev:34.45 (56.0%) stddev-sans-first:36.41 06:18:51 INFO - PROCESS | 2025 | Values: 72.0 78.0 74.0 153.0 57.0 56.0 58.0 65.0 133.0 55.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:81.00 stddev:30.91 (38.2%) stddev-sans-first:32.50 06:18:51 INFO - PROCESS | 2025 | Values: 92.0 92.0 145.0 79.0 78.0 82.0 126.0 80.0 96.0 165.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:88.50 stddev:13.30 (15.0%) stddev-sans-first:14.05 06:18:51 INFO - PROCESS | 2025 | Values: 89.0 87.0 90.0 87.0 130.0 87.0 91.0 88.0 89.0 86.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 06:18:51 INFO - PROCESS | 2025 | Values: 94.0 95.0 95.0 96.0 94.0 95.0 96.0 95.0 94.0 95.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#7] imaging-desaturate Cycles:10 Average:90.50 Median:84.00 stddev:17.24 (20.5%) stddev-sans-first:18.21 06:18:51 INFO - PROCESS | 2025 | Values: 86.0 84.0 84.0 85.0 86.0 82.0 84.0 106.0 134.0 74.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.00 stddev:5.64 (9.1%) stddev-sans-first:5.92 06:18:51 INFO - PROCESS | 2025 | Values: 60.0 64.0 62.0 62.0 61.0 62.0 61.0 77.0 58.0 56.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:67.00 stddev:3.53 (5.3%) stddev-sans-first:3.08 06:18:51 INFO - PROCESS | 2025 | Values: 60.0 64.0 61.0 68.0 68.0 72.0 67.0 65.0 65.0 67.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:80.00 stddev:1.07 (1.3%) stddev-sans-first:1.12 06:18:51 INFO - PROCESS | 2025 | Values: 79.0 80.0 79.0 80.0 79.0 78.0 80.0 79.0 80.0 82.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:139.00 stddev:8.02 (5.8%) stddev-sans-first:8.16 06:18:51 INFO - PROCESS | 2025 | Values: 127.0 126.0 140.0 139.0 143.0 139.0 126.0 123.0 143.0 128.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:163.00 stddev:2.59 (1.6%) stddev-sans-first:2.68 06:18:51 INFO - PROCESS | 2025 | Values: 162.0 163.0 164.0 169.0 163.0 160.0 163.0 162.0 163.0 167.0 06:18:51 INFO - PROCESS | 2025 | 06:18:51 INFO - PROCESS | 2025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.64 06:18:51 INFO - PROCESS | 2025 | Values: 67.0 68.0 68.0 66.0 66.0 66.0 65.0 67.0 70.0 65.0 06:18:51 INFO - PROCESS | 2025 | -------- Summary: end -------- 06:18:51 INFO - PROCESS | 2025 | 06:18:52 INFO - TEST-INFO | 2025: exit 0 06:18:52 INFO - TEST-OK | kraken | took 57920ms 06:18:52 INFO - SUITE-END | took 1171s 06:18:52 INFO - Completed test suite (00:19:32) 06:18:52 INFO - javascript benchmark 06:18:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3509.2279698466336, 3523.0487768302573, 3549.3078849624335, 3572.8034958077305, 3628.7097032237407, 5768.451997060272, 5773.307203135624, 5783.739731712083, 5806.854828629281, 5857.560682948774, 5755.366909639936, 5796.913046304308, 5799.2750906136735, 5813.06990881458, 5828.679422631753, 5222.921656175151, 5254.870202906374, 5290.1800220965815, 5305.867353316159, 5352.732363381835, 5306.204069389584, 5364.624476286662, 5378.354597448292, 5385.272988146608, 5393.78424863005, 5338.119210330291, 5355.705436201008, 5380.650257733254, 5395.757190926398, 5399.7030163341, 5385.084535628933, 5394.0, 5397.946020539823, 5406.02691515527, 5459.181122831567, 5146.6911985281, 5302.92045619316, 5323.9884421959705, 5336.626436149471, 5341.225522299244, 4683.2975053741875, 5598.216249725042, 5658.519025882805, 5686.630369026, 5701.77192912283, 5380.569554435636, 6225.252969643671, 6234.376562343775, 6241.500679945593, 6248.625082495019, 6223.408776166257, 6249.468795152417, 6281.340459251758, 6292.433680968735, 6296.779612713533, 5928.140419639171, 5948.405159484017, 5955.52355811534, 6003.549733769941, 6009.609375390585, 6233.096201050822, 6243.0, 6250.781222657185, 6254.562180647311, 6264.310925798159, 6134.04922237054, 6136.631802091889, 6138.355472675394, 6147.170132032208, 6153.769246150788, 6156.969215153896, 6229.657368844666, 6234.220722409699, 6243.125962365272, 6244.2506899171485, 6211.937880621136, 6239.844003899939, 6243.906341404882, 6247.625142491465, 6271.623702577769, 6207.6275423474735, 6220.968895155495, 6230.937690623126, 6240.968795156086, 6242.875142497215, 4838.758062096881, 4962.404511458648, 4965.131102057126, 5015.423226328946, 5020.995800839773, 4482.798274077609, 4497.078098989699, 4515.096980603892, 4527.094581083797, 4562.5665561771575, 5842.182094506772, 5863.237779088777, 5865.530757539386, 5866.2373891393845, 5870.0, 6172.69136543171, 6237.0, 6259.812205633838, 6276.340984196685, 6280.434760871543, 4875.8049678012485, 5839.678817665069, 5840.59115861894, 5854.970725146347, 5865.090910908816, 5049.444561098277, 5268.815591454358, 5430.104032834538, 5497.725113744297, 5542.778288868481, 6312.368763123743, 6376.872462550816, 6400.911844986364, 6447.968325067966, 6468.644224567505, 6273.278572964167, 6278.623282602875, 6279.905801413074, 6288.0, 6288.559800814082, 6496.187976502937, 6504.674766261763, 6506.479481641552, 6518.543701940818, 6537.346265373425, 6172.876542469216, 6243.594166379171, 6258.499320054476, 6258.561900666909, 6259.718312675849, 5272.6309158358545, 6197.845053873689, 6239.625622462667, 6247.531435142291, 6259.092431597484, 6123.862238009652, 6151.477124444473, 6212.0371342441995, 6213.9067913982235, 6217.844553886189, 6176.258848938156, 6176.4441200292185, 6194.690265486798, 6220.222472190976, 6222.471089957405, 5323.680579165262, 6034.426729460694, 6067.332593414632, 6070.418453112685, 6096.634201947897, 6105.358937311696, 6123.4961516426065, 6192.628442293477, 6218.409251121137, 6222.253329600477, 4638.466576343763, 5958.463738263577, 6048.485878700184, 6077.11881777131, 6119.244515559795], "value": 5752.682459607811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.748369524476, 536.1930294906166, 543.7634628936415, 553.4216743503039, 595.3272801734046, 26300.47399052018, 32564.0230793076, 32749.0, 38371.61628383715, 39360.409593856115, 42142.0, 42687.57312426875, 42734.78632606832, 42738.57261427385, 42761.35857962125, 9621.518924053804, 9863.802723945517, 9879.06148915852, 9881.209503239723, 9888.653897113603, 9168.449893006407, 9634.566444510014, 11776.116791240649, 12062.974647154959, 12082.033437325037, 11690.532378704842, 11762.294262344243, 11765.882341176608, 11779.469923853405, 11789.0, 11682.707932301675, 11827.586034488751, 11835.28388383688, 11840.407979601072, 11844.526218951274, 11564.0, 11629.651110466699, 11643.417829108595, 11672.708182295426, 11676.649700508999, 39294.60705392938, 41258.793706031276, 41388.37917431211, 41429.792851035854, 41441.96395090117, 3283.917902052444, 3351.8156501392414, 3534.469829525566, 3664.0, 3887.280853042196, 28616.856915715496, 28619.57070643942, 28668.283292917637, 29846.40307193844, 29918.401631967456, 2801.8599070046416, 2806.1862060002777, 2810.269329974201, 2884.120343295294, 2900.463414268367, 434479.0, 521072.39463802817, 526251.3687431577, 526645.0, 529653.0, 36655.633443665756, 37282.81358593189, 37284.44073338902, 61167.0, 61566.38433615696, 36430.453543196876, 36489.08777280589, 36538.26923461516, 36544.817275913985, 36637.450438243446, 16119.516414507583, 16264.837351626333, 16267.51197464078, 16288.185590720654, 16294.185290735415, 13021.544245951347, 13044.739105217843, 13698.52055178064, 13803.447862085404, 13825.446982120602, 7901.565413902175, 7993.520388776692, 8305.626246818907, 8520.360972926932, 8532.36007299455, 3412.283420481677, 3471.3057388522398, 3471.7916924984584, 3476.28736109097, 3510.578730552299, 1013.3970287678819, 1072.5066469424153, 1127.4362818590705, 1136.8067428537167, 1154.2093665838927, 29284.97502587399, 29366.853165734035, 29827.254318641775, 29835.95574154894, 29931.0, 796.9123396426388, 1129.5312445335258, 1169.3042639629407, 1177.988220117788, 1206.8793120688038, 13442.395092220873, 15160.696786064216, 15236.3905443781, 15278.006929549543, 15341.232938353038, 635370.0, 643518.7824060849, 643958.0, 644588.0, 646715.0, 58789.118163227584, 60967.390326096174, 61020.0, 61035.38964610386, 61463.385366146664, 1406.3319923036477, 1468.1924941282252, 1504.8269449013503, 1525.519461369665, 1592.4506045414314, 28864.278393040342, 29108.417831643674, 29593.816247349863, 30102.0, 30110.84944575351, 46015.0, 46119.3082103762, 46398.76800615976, 46523.534764653275, 46567.767161163974, 380663.0, 386444.0677796593, 387641.0, 389496.0, 620768.0, 26686.86656566705, 27496.58755118715, 27500.449991000467, 27514.862425687745, 27515.17454476369, 42101.36847947344, 43676.781616091714, 43939.56060439483, 44028.119437610425, 44559.33161002652, 30136.0, 35390.64609353874, 36352.81823590865, 36389.90830275096, 37042.0, 27995.86002070058, 35571.0, 36253.818730906176, 37253.81373093117, 37726.62273377231, 37248.0, 38254.808725956194, 38447.423288651255, 39165.82502524929, 39710.823134148624, 31207.687923120477, 31490.685093148775, 31752.841235793672, 31908.5213721799, 31936.840315798272, 24084.39789005289, 24324.635130472703, 24374.51250975006, 24827.627585586593, 24887.253382398558], "value": 18795.124065398042, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9805316883673, 385.79167249685173, 393.30974140383614, 401.6184624606623, 416.09084151129804, 15972.600684982881, 16025.679486410265, 20405.897970510145, 21136.89431552842, 21147.99999999998, 17322.480325590222, 20617.175312987463, 21204.0, 21399.57200855982, 22141.557168856652, 4900.681455705386, 4913.484084171164, 5566.86082847929, 5747.856303592402, 5759.712014399284, 4180.895477613054, 4381.780910954455, 4789.80840766369, 6133.049377346519, 6252.468540174091, 3754.906127346811, 4367.213901497729, 4380.145871555048, 5952.166696662471, 6296.150019747344, 5151.948480515184, 5339.439358867321, 6203.751849925998, 6255.218097737783, 6273.3726627337355, 6137.6624285664275, 6171.321154672983, 6172.567920245585, 6181.3818618138275, 6182.783602573933, 13743.244121573309, 14375.0, 14380.496682616164, 14419.35112919921, 14530.491432799907, 2283.4291427143216, 2367.8342516023886, 2448.461338505526, 2448.7306396296394, 2809.9157025289273, 10237.692869213935, 10549.103326217204, 10761.0, 10957.671269861918, 12367.443465044005, 1780.9554761130946, 1819.6198596236422, 1873.653374125791, 1910.3695780392436, 2070.6997485364536, 85000.0, 119105.40447297708, 122419.38790306081, 123716.38141809234, 123856.0, 11806.232594881305, 11819.349935753617, 12118.151729379035, 12164.939175304067, 12229.082818788627, 15828.60428489297, 15900.68198636044, 15945.123018233877, 15957.601059973362, 15964.521064367855, 8578.056413794478, 9026.593803278869, 9291.767705807273, 9376.578053987587, 9473.478958657202, 9177.128172823572, 9214.63141474347, 9350.0, 9413.0, 9503.287253455881, 4845.75771211438, 4920.794405370707, 4945.109880221595, 4946.738581661725, 4964.851054468371, 2045.4681782736595, 2045.7954204579423, 2050.7846676098793, 2076.6884967255032, 2119.777423370524, 817.5789468423767, 855.897292324925, 957.6935380678116, 960.4429430930044, 1029.0275689473376, 20903.37289881306, 21750.803705796017, 21804.890975545022, 21873.343799686034, 21957.451063723536, 999.2256001598819, 1036.7200855769051, 1044.4046893270915, 1073.9904489779583, 1083.4311986207147, 11288.830667539993, 11522.423878806027, 11543.307401555934, 11556.959873611415, 11695.649130526097, 597011.0, 597876.0, 603542.0, 605594.0, 613944.0, 82491.3501729962, 130132.0, 131394.0, 131444.0, 133738.33130834284, 971.2958105373548, 1018.7367664096615, 1036.7554245059512, 1040.266612038511, 1061.2412125330425, 15295.694086118438, 15887.761683574525, 18578.163982620543, 18911.621767564848, 19482.4155275342, 53063.2243098123, 54413.18380224379, 54577.0, 54684.0, 55167.72416137894, 76622.0, 78953.0, 79954.60022699849, 80233.0, 82429.0, 8278.668853245803, 8547.82904341922, 8626.223639872442, 8781.121887811169, 8824.514651694219, 9583.712488625353, 12730.745385092061, 12987.675308117372, 13013.0, 13252.469901203844, 10390.896091038992, 10869.967353101443, 11081.390523521284, 11419.200655954335, 11651.0, 11107.611233606785, 11210.887891120985, 11259.268147570381, 11482.679491858544, 11528.654140375467, 11493.425328733363, 11546.59586914454, 11759.647210583697, 11951.820722688994, 12116.030717542399, 8137.226963438464, 8388.496690198608, 8410.327173826201, 8669.263112635497, 8858.557072146496, 8477.74566762998, 9469.384490008128, 9604.471754053595, 10470.371777693363, 11577.479013444583], "value": 9558.64381393377, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.2118316700567, 1592.0765955745665, 1619.4736710569064, 1897.0, 2015.3953813855849, 8259.669613215472, 8903.287736981043, 9062.320325975545, 9076.22852057576, 9082.273418126551, 8740.300775937925, 9016.09839016098, 9036.8644470333, 9049.2308153807, 9052.683156089539, 2564.3204550794053, 2592.44262483566, 2594.7924166066764, 2594.8572828494425, 2596.8961241550314, 2523.1547431610434, 2578.8323758955703, 2581.9612705809427, 2583.3799888026924, 2591.883365248568, 2562.5387430262545, 2584.1859814158574, 2597.870106494677, 2600.1809430029575, 2602.2193341997418, 2499.4751102268547, 2524.1291754344907, 2528.3426309159568, 2579.9871000645066, 2592.2482480080753, 2463.581191197483, 2491.638712386712, 2507.962380564293, 2586.3275548357565, 2588.327034970921, 8893.0, 9184.494852783095, 9246.214071803837, 9249.953750231272, 9253.814923701555, 5687.630304030266, 5781.4507621775865, 5783.045797443417, 5797.449242321973, 5870.354261031283, 3649.251903359805, 3717.8512859485586, 3776.395776675746, 3785.0915780212827, 3793.4499497572697, 1036.259074761549, 1047.0576481166934, 1047.8899715529913, 1058.8094143054248, 1081.9505080072395, 12235.204711693801, 12327.952124069465, 12477.688057798629, 12601.432935517923, 12608.74782504354, 4030.1939612077704, 4761.952380476151, 4880.926786098212, 4888.853334399973, 4900.534449227318, 9701.757456063513, 9716.02839716037, 9728.513574321256, 9733.951330243304, 9740.074692904163, 4856.68431551948, 5606.6636001840025, 5666.603337766399, 5677.318721753416, 5679.772809087673, 4660.790264438108, 4761.904761904742, 4817.807287708522, 4825.638077144228, 5232.1628539433505, 3940.6650434712797, 4301.161273551627, 4308.116836048603, 4332.718373305725, 4338.327559228324, 1387.1053170704838, 1403.929803509841, 1415.7168566286578, 1422.7225690990365, 1431.119861285323, 872.7774417523491, 950.8431108867098, 962.1244667352676, 964.6864768950119, 981.3817295104182, 6035.939640603626, 6168.35232300602, 6194.225721784777, 6208.72060757267, 6234.3453937336835, 957.8898426680881, 1003.7340104872214, 1010.6412223660642, 1015.6394479959656, 1039.679606899249, 4041.9595804041583, 4104.8152833122585, 4113.403556484293, 4160.18876319121, 4166.729162604421, 10655.84016239757, 11008.449577521253, 11022.393768342657, 11167.553297868157, 11178.105751539857, 10903.236773425784, 10960.451977401099, 10984.835227471594, 10987.121030317556, 11077.446127693584, 8189.50862948225, 8413.789655258668, 8452.112528184574, 8516.74449766508, 8623.267022303175, 6068.6358818471035, 6102.809952059306, 6158.784442544489, 6165.5375846810775, 6217.906731399123, 9660.130588247092, 9710.514474276399, 9816.2147028239, 9834.262430317613, 9867.457289849128, 9577.616895324109, 10042.49787510636, 10053.19574434058, 10264.538095785856, 10264.897351026395, 6995.405390541861, 7186.10173728284, 7188.676509556978, 7683.270089341504, 7903.84192316162, 8167.714130005421, 8679.739607811776, 8695.826083478421, 8696.260817830555, 8713.215810577078, 7534.736284230245, 7683.9231607683205, 7738.41961852852, 7786.26030527099, 7829.0, 7544.132424771002, 7581.848363032819, 7609.6575654094595, 7733.149353570991, 7752.186020467995, 7249.565026098451, 7301.707931682673, 7322.304381083789, 7383.963080184565, 7406.7037318506655, 4968.950310496849, 5022.547970682656, 5052.0, 5152.742362881766, 5173.430922598586, 5021.548060674557, 5087.287779710769, 5150.381954165524, 5185.896282074413, 5238.580913526985], "value": 4789.196549491523, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.01965232043943, 340.05295252721174, 346.0794287196058, 348.93544694231554, 352.67377675650016, 6892.758753443624, 6894.0, 6900.275471075527, 6921.65391730414, 6935.9653201734045, 6697.631630260334, 6808.523403361766, 6948.478864085201, 6959.8956015659805, 6960.860782784354, 4907.779149938261, 5025.974870125644, 5061.797528098871, 5099.133147364938, 5135.972805438909, 5093.79624815007, 5198.246254293125, 5201.349831271091, 5210.5310522053005, 5219.973900130494, 5131.0, 5134.589232861381, 5136.409312929005, 5139.203423469368, 5147.4080480744815, 4876.390451193601, 4967.801287948478, 5053.0, 5055.140626093536, 5060.342155519796, 4306.569343065699, 4322.978385108055, 4329.285667864799, 4330.675199360029, 4339.305711086211, 6593.86812263752, 6701.899471507932, 6729.461643068543, 6782.966085169592, 6874.931250687529, 6059.182480146709, 6079.331273559905, 6083.057126145454, 6084.574079814415, 6096.72564734588, 7171.784846454615, 7406.925930740731, 7412.295831895961, 7421.703131874719, 7446.218147094532, 4894.583960363338, 4938.851834444972, 4946.5795407390415, 4952.306677065214, 4967.602591792648, 7799.181085985946, 7802.531848089133, 7810.687572497093, 7812.726554570563, 7822.452428330019, 5001.874953126201, 5013.1227035268685, 5015.623828212899, 5024.79900803971, 5030.773615187325, 5098.796048158032, 5101.0, 5108.897822043538, 5118.411382690963, 5126.128558145124, 5858.384869588717, 6065.423784740443, 6073.726682299307, 6082.543809214327, 6089.908651370233, 7378.077740282465, 7418.369438597671, 7426.257374262531, 7429.368503677248, 7451.552906825499, 1748.9562760931078, 1779.6885545029568, 1781.536800431897, 1782.3761683410962, 1783.9643207135784, 1063.3407287481657, 1079.740862193068, 1117.8379135025375, 1138.1179585821055, 1159.878212787662, 5569.777208911679, 6789.558678685869, 6791.388775010174, 6865.691043903036, 6939.271376505394, 6273.560850740404, 7804.726834560876, 7808.960955195188, 7809.843803123906, 7810.258025487683, 6180.825643127791, 6669.7665581704405, 7087.1849737279845, 7099.716011359591, 7103.325184107502, 3974.125692347679, 4069.023434375788, 4128.91742165161, 4129.710920235615, 4132.40080188371, 6357.855585994565, 8087.110417854032, 8129.837403251902, 8150.307223885918, 8155.836883262302, 6437.613743175424, 8036.517808931483, 8051.194880511902, 8051.355891528664, 8056.516609003478, 6153.38466153399, 8111.18888111196, 8155.592220389076, 8158.469699469515, 8172.877406838902, 7426.554406735613, 7681.116671582839, 7692.42306826979, 7750.031246094239, 7768.262015108556, 7588.734394296394, 7622.9237707622215, 7641.694332226649, 7647.770566883002, 7653.272939070779, 8136.308413784895, 8144.511329320259, 8150.592470376576, 8151.0, 8159.959200203961, 4397.890052748707, 4542.954570454385, 4822.987172693774, 4885.706857588556, 4890.486498917562, 7487.438442116754, 7743.264389882952, 7764.88352674699, 7765.495242809199, 7778.727744529141, 6095.969520152371, 7431.29402706742, 7454.813629659302, 7488.625568721651, 7500.624968751432, 7463.731165701953, 7467.925320746723, 7479.700811967678, 7482.551046937201, 7492.213317601573, 6993.895091573732, 7298.087739032621, 7299.781006569811, 7301.963490182515, 7312.1591017033725, 7379.926200737924, 7468.887966680612, 7500.399968002437, 7501.174870764321, 7532.0208372911175, 7041.894371584328, 7163.820904477429, 7201.243869393638, 7353.264673532604, 7364.705411783469], "value": 5435.668621861763, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.9477289203311, 714.9177844547877, 764.8623247815391, 792.1959211400426, 792.615581443, 15347.3093710783, 15566.299516521756, 15568.68862622747, 15593.0, 15614.0, 11960.581379651714, 13889.30553472325, 14375.856241437583, 14384.71230575388, 14389.496367627135, 751.7631945937026, 778.5873487051844, 932.1889955738517, 961.4663861556833, 963.5037955452947, 937.0535758883543, 947.497826152137, 950.4202436513721, 950.6292545907102, 952.6903756279203, 808.9797755056112, 999.7200783780517, 1000.4697510319506, 1002.904724051214, 1003.0120331473493, 984.6406061787468, 1010.2322235101376, 1012.4330374989955, 1012.549415510091, 1014.6093753904726, 750.7072241825692, 750.962451877404, 751.0724255544399, 751.7970148060048, 753.0473950452682, 12502.312372819491, 15293.541193764206, 15300.08199508033, 15305.61735956599, 15308.0, 13068.0, 13173.473061077546, 13272.203667779868, 13296.72465255796, 13367.933160334136, 9957.701268961942, 10025.19798416125, 10069.949650251701, 10331.845022324596, 10694.839577406266, 3570.0896271450615, 3587.7667951583326, 3610.891673249807, 3661.0664280608275, 3835.635614616635, 72797.0, 87611.0, 88804.5559772197, 90805.0, 90945.54527227322, 9719.951400242953, 9821.754456138653, 9841.753956151153, 9878.555465004092, 9930.354526955725, 22923.885380573323, 22947.885260573592, 22952.0, 22962.081516739476, 22962.311130665774, 7643.656035478306, 7645.273698998586, 7715.22847715224, 7715.768526944201, 7931.722389716448, 3604.225091605265, 4278.4865816102265, 4350.412694286294, 4374.5625437456, 4428.269335559597, 3728.2357116790995, 3781.5273090863643, 3788.1476667749534, 3793.7534060285993, 3799.3351163546267, 532.1884126706726, 614.1095411653121, 635.6948664640998, 653.3140202787055, 658.5949640970864, 495.7694671977476, 529.6530772344121, 548.8134034428314, 553.6788662575697, 609.460627344803, 7881.408894332948, 8301.46040507365, 8370.372222083246, 8411.831763364698, 8585.835959161592, 539.6384422436977, 557.8410153106427, 572.899742545053, 576.5646936562869, 628.1206311164407, 3812.6187381262207, 3989.68082553395, 4022.8994275143355, 4049.149678567534, 4190.685698572619, 87933.56033219793, 89051.0, 90437.64343534852, 90563.18873622491, 91257.0, 56034.0, 71969.92045119328, 72480.63759681168, 72929.0, 73017.90473142907, 65974.0, 66753.33246667568, 70859.0, 71054.93417598741, 72678.63660681662, 8528.232459078712, 8587.22714955632, 8659.696910608098, 8877.600507977286, 8905.109489051301, 47613.42494976751, 48612.0, 49192.26211606757, 50382.0, 51431.74284128555, 64186.0, 64746.35253647592, 65427.345726542124, 66354.00468992873, 66374.66812665906, 10825.404602746925, 11157.0, 11216.214864959375, 11295.3787541686, 11490.77018459643, 11428.714282143013, 12150.817737733763, 12163.574274900337, 12356.135070544975, 12551.184173028723, 11493.942530287295, 11663.475143618387, 11696.70758231051, 11697.590584329508, 12129.332886691316, 11195.944020279847, 11546.107588504432, 11564.537418503165, 11598.420078996185, 12095.911367976923, 11232.382218978035, 11323.433828308716, 11351.14866385008, 11659.125565582446, 11692.298462092302, 9687.903120968982, 9865.309428339948, 10071.295009349275, 10109.0, 10407.58369665205, 9975.800483990424, 10174.898251017396, 10183.0, 10215.0, 10228.897711022795], "value": 7019.67528026765, "unit": "score"}], "name": "dromaeo_css", "value": 7574.6545816604785, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 117.0, 114.0, 118.0, 162.0, 167.0, 132.0, 114.0, 132.0], "value": 128.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 120.0, 146.0, 163.0, 116.0, 141.0, 141.0, 117.0, 168.0, 119.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 188.0, 184.0, 187.0, 184.0, 182.0, 186.0, 185.0, 186.0], "value": 185.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 78.0, 74.0, 153.0, 57.0, 56.0, 58.0, 65.0, 133.0, 55.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 145.0, 79.0, 78.0, 82.0, 126.0, 80.0, 96.0, 165.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 87.0, 130.0, 87.0, 91.0, 88.0, 89.0, 86.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 94.0, 95.0, 96.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 85.0, 86.0, 82.0, 84.0, 106.0, 134.0, 74.0], "value": 90.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 62.0, 62.0, 61.0, 62.0, 61.0, 77.0, 58.0, 56.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 61.0, 68.0, 68.0, 72.0, 67.0, 65.0, 65.0, 67.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 80.0, 79.0, 78.0, 80.0, 79.0, 80.0, 82.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 140.0, 139.0, 143.0, 139.0, 126.0, 123.0, 143.0, 128.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 169.0, 163.0, 160.0, 163.0, 162.0, 163.0, 167.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 66.0, 66.0, 66.0, 65.0, 67.0, 70.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1485.4999999999998, "alertThreshold": 2.0}]} 06:18:52 INFO - Return code: 0 06:18:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:18:52 ERROR - # TBPL SUCCESS # 06:18:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:18:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:18:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:18:52 INFO - 2016-06-27 06:18:52.754 screenresolution[2029:14267] starting screenresolution argv=screenresolution get 06:18:52 INFO - 2016-06-27 06:18:52.756 screenresolution[2029:14267] Display 0: 1600x1200x32@60 06:18:52 INFO - 2016-06-27 06:18:52.762 screenresolution[2030:14270] starting screenresolution argv=screenresolution list 06:18:52 INFO - Available Modes on Display 0 06:18:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:18:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:18:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:18:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:18:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:18:52 INFO - Intel Iris: 06:18:52 INFO - Chipset Model: Intel Iris 06:18:52 INFO - Type: GPU 06:18:52 INFO - Bus: Built-In 06:18:52 INFO - VRAM (Dynamic, Max): 1536 MB 06:18:52 INFO - Vendor: Intel (0x8086) 06:18:52 INFO - Device ID: 0x0a2e 06:18:52 INFO - Revision ID: 0x0009 06:18:52 INFO - Displays: 06:18:52 INFO - Display: 06:18:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:18:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:18:52 INFO - Display Serial Number: 1600x1200 60 06:18:52 INFO - Main Display: Yes 06:18:52 INFO - Mirror: Off 06:18:52 INFO - Online: Yes 06:18:52 INFO - Rotation: Supported 06:18:52 INFO - Return code: 0 06:18:52 INFO - Running post-action listener: _resource_record_post_action 06:18:52 INFO - Running post-run listener: _resource_record_post_run 06:18:54 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 299008; Write bytes: 493846016; Read time: 4; Write time: 1524 06:18:54 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 186882560; Write bytes: 184713216; Read time: 17528; Write time: 388 06:18:54 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 299008; Write bytes: 298343936; Read time: 4; Write time: 1098 06:18:54 INFO - Running post-run listener: _upload_blobber_files 06:18:54 INFO - Blob upload gear active. 06:18:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:54 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 06:18:54 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'] 06:18:54 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 06:18:54 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:18:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:18:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:55 INFO - (blobuploader) - INFO - Done attempting. 06:18:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:18:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:18:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:56 INFO - (blobuploader) - INFO - Done attempting. 06:18:56 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:56 INFO - Return code: 0 06:18:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3c8b090cf62d1d53c7f78e9ac469df8e67cfb60ce208e7dd3aca5839bd99e3d61511b0ecd23ae3160c171693885e483e7f427e2dd63471f4a72d8c80ec5707f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/584f9914b5822866231886a1c6e50adaa3fee9ad648f42b103e23ebfe414258ad6f65f8cff10251fcc5993d9fe50113706516ff8207e19ceaeed049fe8aa3ae7"} 06:18:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:56 INFO - Contents: 06:18:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3c8b090cf62d1d53c7f78e9ac469df8e67cfb60ce208e7dd3aca5839bd99e3d61511b0ecd23ae3160c171693885e483e7f427e2dd63471f4a72d8c80ec5707f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/584f9914b5822866231886a1c6e50adaa3fee9ad648f42b103e23ebfe414258ad6f65f8cff10251fcc5993d9fe50113706516ff8207e19ceaeed049fe8aa3ae7"} 06:18:56 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:56 INFO - Copying logs to upload dir... 06:18:56 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.819427 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-06-27 06:18:56.517449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:56.525136) ========= 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.KV8tjsGEfp/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.WZZal4SkcK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3c8b090cf62d1d53c7f78e9ac469df8e67cfb60ce208e7dd3aca5839bd99e3d61511b0ecd23ae3160c171693885e483e7f427e2dd63471f4a72d8c80ec5707f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/584f9914b5822866231886a1c6e50adaa3fee9ad648f42b103e23ebfe414258ad6f65f8cff10251fcc5993d9fe50113706516ff8207e19ceaeed049fe8aa3ae7"} build_url:https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010923 build_url: 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3c8b090cf62d1d53c7f78e9ac469df8e67cfb60ce208e7dd3aca5839bd99e3d61511b0ecd23ae3160c171693885e483e7f427e2dd63471f4a72d8c80ec5707f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/584f9914b5822866231886a1c6e50adaa3fee9ad648f42b103e23ebfe414258ad6f65f8cff10251fcc5993d9fe50113706516ff8207e19ceaeed049fe8aa3ae7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:56.560344) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:56.560676) ========= 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.KV8tjsGEfp/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.WZZal4SkcK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.005191 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:56.609499) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:18:56.612850) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:18:56.613176) ========= ========= Total master_lag: 0.19 =========