builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0030 starttime: 1465219065.58 results: success (0) buildid: 20160602140837 builduid: 893fdbbbce3544769bc98c5128e2bb0b revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.580104) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.580448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.580709) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.678311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 06:17:45.678576) ========= 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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-06 06:17:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.7M=0s 2016-06-06 06:17:46 (25.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.535005 ========= master_lag: 1.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 06:17:47.658518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:47.658889) ========= 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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.028089 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:47.719148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 06:17:47.719528) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --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 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.W80Om5xNdd/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.7SmhZkZ1Td/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-06 06:17:47,792 truncating revision to first 12 chars 2016-06-06 06:17:47,792 Setting DEBUG logging. 2016-06-06 06:17:47,792 attempt 1/10 2016-06-06 06:17:47,792 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6e2399cf03e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 06:17:48,899 unpacking tar archive at: mozilla-beta-6e2399cf03e2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.380116 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 06:17:49.223598) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:49.223939) ========= script_repo_revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:49.224434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:49.224732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:49.245094) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-06 06:17:49.245437) ========= /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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 06:17:49 INFO - MultiFileLogger online at 20160606 06:17:49 in /builds/slave/test 06:17:49 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 06:17:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:17:49 INFO - {'append_to_log': False, 06:17:49 INFO - 'base_work_dir': '/builds/slave/test', 06:17:49 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:17:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:17:49 INFO - 'branch': 'Mozilla-Beta', 06:17:49 INFO - 'buildbot_json_path': 'buildprops.json', 06:17:49 INFO - 'config_files': ('talos/mac_config.py',), 06:17:49 INFO - 'default_actions': ('clobber', 06:17:49 INFO - 'read-buildbot-config', 06:17:49 INFO - 'download-and-extract', 06:17:49 INFO - 'populate-webroot', 06:17:49 INFO - 'create-virtualenv', 06:17:49 INFO - 'install', 06:17:49 INFO - 'run-tests'), 06:17:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:17:49 INFO - 'download_minidump_stackwalk': True, 06:17:49 INFO - 'download_symbols': 'ondemand', 06:17:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:17:49 INFO - 'tooltool.py': '/tools/tooltool.py', 06:17:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:17:49 INFO - '/tools/misc-python/virtualenv.py')}, 06:17:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:17:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:17:49 INFO - 'installer_path': 'installer.exe', 06:17:49 INFO - 'log_level': 'info', 06:17:49 INFO - 'log_name': 'talos', 06:17:49 INFO - 'log_to_console': True, 06:17:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:17:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:17:49 INFO - 'opt_config_files': (), 06:17:49 INFO - 'pip_index': False, 06:17:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:17:49 INFO - 'cmd': ('bash', 06:17:49 INFO - '-c', 06:17:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:17:49 INFO - 'enabled': True, 06:17:49 INFO - 'halt_on_failure': False, 06:17:49 INFO - 'name': 'check_screen_resolution'},), 06:17:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:17:49 INFO - 'cmd': ('bash', 06:17:49 INFO - '-c', 06:17:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:17:49 INFO - 'enabled': True, 06:17:49 INFO - 'halt_on_failure': False, 06:17:49 INFO - 'name': 'check_screen_resolution'},), 06:17:49 INFO - 'run_cmd_checks_enabled': True, 06:17:49 INFO - 'sps_profile': False, 06:17:49 INFO - 'sps_profile_interval': 0, 06:17:49 INFO - 'suite': 'dromaeojs', 06:17:49 INFO - 'system_bits': '32', 06:17:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:17:49 INFO - 'title': 't-yosemite-r7-0030', 06:17:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:17:49 INFO - 'use_talos_json': True, 06:17:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:17:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:17:49 INFO - 'work_dir': 'build'} 06:17:49 INFO - ##### 06:17:49 INFO - ##### Running clobber step. 06:17:49 INFO - ##### 06:17:49 INFO - Running pre-action listener: _resource_record_pre_action 06:17:49 INFO - Running main action method: clobber 06:17:49 INFO - rmtree: /builds/slave/test/build 06:17:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:17:51 INFO - Running post-action listener: _resource_record_post_action 06:17:51 INFO - ##### 06:17:51 INFO - ##### Running read-buildbot-config step. 06:17:51 INFO - ##### 06:17:51 INFO - Running pre-action listener: _resource_record_pre_action 06:17:51 INFO - Running main action method: read_buildbot_config 06:17:51 INFO - Using buildbot properties: 06:17:51 INFO - { 06:17:51 INFO - "project": "", 06:17:51 INFO - "product": "firefox", 06:17:51 INFO - "script_repo_revision": "production", 06:17:51 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:17:51 INFO - "repository": "", 06:17:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:17:51 INFO - "buildid": "20160602140837", 06:17:51 INFO - "pgo_build": "False", 06:17:51 INFO - "basedir": "/builds/slave/test", 06:17:51 INFO - "buildnumber": 1, 06:17:51 INFO - "slavename": "t-yosemite-r7-0030", 06:17:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:17:51 INFO - "platform": "yosemite_r7", 06:17:51 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:17:51 INFO - "branch": "mozilla-beta", 06:17:51 INFO - "repo_path": "releases/mozilla-beta", 06:17:51 INFO - "revision": "6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea", 06:17:51 INFO - "stage_platform": "macosx64", 06:17:51 INFO - "builduid": "893fdbbbce3544769bc98c5128e2bb0b", 06:17:51 INFO - "slavebuilddir": "test" 06:17:51 INFO - } 06:17:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 06:17:51 INFO - Running post-action listener: _resource_record_post_action 06:17:51 INFO - ##### 06:17:51 INFO - ##### Running download-and-extract step. 06:17:51 INFO - ##### 06:17:51 INFO - Running pre-action listener: _resource_record_pre_action 06:17:51 INFO - Running main action method: download_and_extract 06:17:51 INFO - mkdir: /builds/slave/test/build/tests 06:17: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')]} 06:17:51 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:17:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:17:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:17:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 06:17:53 INFO - Downloaded 1241 bytes. 06:17:53 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:17:53 INFO - Using the following test package requirements: 06:17:53 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:17:53 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:53 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 06:17:53 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:53 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 06:17:53 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:17:53 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:53 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 06:17:53 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:17:53 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:53 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 06:17:53 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:53 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 06:17:53 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:53 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 06:17:53 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:17:53 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:53 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 06:17:53 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 06:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:53 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:17:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:17:54 INFO - Downloaded 17816944 bytes. 06:17:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:17:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:17:57 INFO - Return code: 0 06:17:57 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:57 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:17:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:18:01 INFO - Downloaded 17816944 bytes. 06:18:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:18:05 INFO - Return code: 0 06:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:05 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 06:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 06:18:06 INFO - Downloaded 10845194 bytes. 06:18:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:18:06 INFO - Return code: 0 06:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:06 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 06:18:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:18:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:18:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 06:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 06:18:10 INFO - Downloaded 88466458 bytes. 06:18:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:18:10 INFO - mkdir: /builds/slave/test/properties 06:18:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:18:10 INFO - Writing to file /builds/slave/test/properties/build_url 06:18:10 INFO - Contents: 06:18:10 INFO - build_url:https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:18:11 INFO - Running post-action listener: _resource_record_post_action 06:18:11 INFO - Running post-action listener: set_extra_try_arguments 06:18:11 INFO - ##### 06:18:11 INFO - ##### Running populate-webroot step. 06:18:11 INFO - ##### 06:18:11 INFO - Running pre-action listener: _resource_record_pre_action 06:18:11 INFO - Running main action method: populate_webroot 06:18:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:18:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:18:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:18:11 INFO - '--tppagecycles', 06:18:11 INFO - '7'], 06:18:11 INFO - 'tests': ['tsvgm']}}, 06:18:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:18:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:18:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:18:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:18:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:18:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:18:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:11 INFO - 'talos_options': ['--e10s'], 06:18:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:11 INFO - 'tests': ['damp', 'tps']}, 06:18:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:11 INFO - 'talos_options': ['--e10s'], 06:18:11 INFO - 'tests': ['damp', 'tps']}, 06:18:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:18:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:18:11 INFO - 'other': {'tests': ['a11yr', 06:18:11 INFO - 'ts_paint', 06:18:11 INFO - 'tpaint', 06:18:11 INFO - 'sessionrestore', 06:18:11 INFO - 'sessionrestore_no_auto_restore', 06:18:11 INFO - 'tabpaint']}, 06:18:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:18:11 INFO - 'tests': ['a11yr', 06:18:11 INFO - 'ts_paint', 06:18:11 INFO - 'tpaint', 06:18:11 INFO - 'sessionrestore', 06:18:11 INFO - 'sessionrestore_no_auto_restore', 06:18:11 INFO - 'tabpaint']}, 06:18:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:18:11 INFO - 'tests': ['a11yr', 06:18:11 INFO - 'ts_paint', 06:18:11 INFO - 'tpaint', 06:18:11 INFO - 'sessionrestore', 06:18:11 INFO - 'sessionrestore_no_auto_restore', 06:18:11 INFO - 'tabpaint']}, 06:18:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:18:11 INFO - 'tests': ['a11yr', 06:18:11 INFO - 'ts_paint', 06:18:11 INFO - 'tpaint', 06:18:11 INFO - 'sessionrestore', 06:18:11 INFO - 'sessionrestore_no_auto_restore', 06:18:11 INFO - 'tabpaint']}, 06:18:11 INFO - 'other_l64': {'tests': ['a11yr', 06:18:11 INFO - 'ts_paint', 06:18:11 INFO - 'tpaint', 06:18:11 INFO - 'sessionrestore', 06:18:11 INFO - 'sessionrestore_no_auto_restore', 06:18:11 INFO - 'tabpaint']}, 06:18:11 INFO - 'other_nol64': {'tests': ['a11yr', 06:18:11 INFO - 'ts_paint', 06:18:11 INFO - 'tpaint', 06:18:11 INFO - 'sessionrestore', 06:18:11 INFO - 'sessionrestore_no_auto_restore', 06:18:11 INFO - 'tabpaint']}, 06:18:11 INFO - 'svgr': {'tests': ['tsvgx', 06:18:11 INFO - 'tsvgr_opacity', 06:18:11 INFO - 'tart', 06:18:11 INFO - 'tscrollx', 06:18:11 INFO - 'cart']}, 06:18:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:18:11 INFO - 'tests': ['tsvgx', 06:18:11 INFO - 'tsvgr_opacity', 06:18:11 INFO - 'tart', 06:18:11 INFO - 'tscrollx', 06:18:11 INFO - 'cart']}, 06:18:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:11 INFO - 'tests': ['tp5o']}, 06:18:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:11 INFO - 'talos_options': ['--e10s'], 06:18:11 INFO - 'tests': ['tp5o']}, 06:18:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:11 INFO - 'talos_options': ['--xperf_path', 06:18:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:11 INFO - 'tests': ['tp5n']}, 06:18:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:11 INFO - 'talos_options': ['--e10s', 06:18:11 INFO - '--xperf_path', 06:18:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:11 INFO - 'tests': ['tp5n']}}, 06:18:11 INFO - 'talos.zip': {'path': '', 06:18:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:18:11 INFO - Running post-action listener: _resource_record_post_action 06:18:11 INFO - ##### 06:18:11 INFO - ##### Running create-virtualenv step. 06:18:11 INFO - ##### 06:18:11 INFO - Running pre-action listener: _resource_record_pre_action 06:18:11 INFO - Running main action method: create_virtualenv 06:18:11 INFO - Creating virtualenv /builds/slave/test/build/venv 06:18:11 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 06:18:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:18:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:18:12 INFO - Using real prefix '/tools/python27' 06:18:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:18:12 INFO - Installing distribute.............................................................................................................................................................................................done. 06:18:15 INFO - Installing pip.................done. 06:18:15 INFO - Return code: 0 06:18:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:15 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 0x10c212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd98a4ccc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0b6d30>, '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 0x10bf1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0adb20>, '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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 06:18:15 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 06:18:15 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 06:18:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W80Om5xNdd/Render', 06:18:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:15 INFO - 'HOME': '/Users/cltbld', 06:18:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:15 INFO - 'LOGNAME': 'cltbld', 06:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:15 INFO - 'MOZ_NO_REMOTE': '1', 06:18:15 INFO - 'NO_EM_RESTART': '1', 06:18:15 INFO - 'PAGER': '/bin/cat', 06:18:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:15 INFO - 'PWD': '/builds/slave/test', 06:18:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:15 INFO - 'SHELL': '/bin/bash', 06:18:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SmhZkZ1Td/Listeners', 06:18:15 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 06:18:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:15 INFO - 'USER': 'cltbld', 06:18:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:15 INFO - 'XPC_FLAGS': '0x0', 06:18:15 INFO - 'XPC_SERVICE_NAME': '0', 06:18:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:15 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 06:18:15 INFO - Cleaning up... 06:18:15 INFO - Return code: 0 06:18:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:15 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 0x10c212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd98a4ccc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0b6d30>, '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 0x10bf1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0adb20>, '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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 06:18:15 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 06:18:15 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 06:18:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W80Om5xNdd/Render', 06:18:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:15 INFO - 'HOME': '/Users/cltbld', 06:18:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:15 INFO - 'LOGNAME': 'cltbld', 06:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:15 INFO - 'MOZ_NO_REMOTE': '1', 06:18:15 INFO - 'NO_EM_RESTART': '1', 06:18:15 INFO - 'PAGER': '/bin/cat', 06:18:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:15 INFO - 'PWD': '/builds/slave/test', 06:18:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:15 INFO - 'SHELL': '/bin/bash', 06:18:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SmhZkZ1Td/Listeners', 06:18:15 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 06:18:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:15 INFO - 'USER': 'cltbld', 06:18:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:15 INFO - 'XPC_FLAGS': '0x0', 06:18:15 INFO - 'XPC_SERVICE_NAME': '0', 06:18:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:16 INFO - Downloading/unpacking psutil>=0.7.1 06:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:18:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:19 INFO - Installing collected packages: psutil 06:18:19 INFO - Running setup.py install for psutil 06:18:19 INFO - building 'psutil._psutil_osx' extension 06:18:19 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 06:18:20 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 06:18:20 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 06:18:20 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 06:18:20 INFO - building 'psutil._psutil_posix' extension 06:18:20 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 06:18:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:18:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:18:20 INFO - ^ 06:18:20 INFO - 1 warning generated. 06:18:20 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 06:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:20 INFO - Successfully installed psutil 06:18:20 INFO - Cleaning up... 06:18:20 INFO - Return code: 0 06:18:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:18:20 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')]} 06:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:20 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')]} 06:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:20 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 0x10c212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd98a4ccc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0b6d30>, '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 0x10bf1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0adb20>, '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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 06:18:20 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 06:18:20 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 06:18:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W80Om5xNdd/Render', 06:18:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:20 INFO - 'HOME': '/Users/cltbld', 06:18:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:20 INFO - 'LOGNAME': 'cltbld', 06:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:20 INFO - 'MOZ_NO_REMOTE': '1', 06:18:20 INFO - 'NO_EM_RESTART': '1', 06:18:20 INFO - 'PAGER': '/bin/cat', 06:18:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:20 INFO - 'PWD': '/builds/slave/test', 06:18:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:20 INFO - 'SHELL': '/bin/bash', 06:18:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SmhZkZ1Td/Listeners', 06:18:20 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 06:18:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:20 INFO - 'USER': 'cltbld', 06:18:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:20 INFO - 'XPC_FLAGS': '0x0', 06:18:20 INFO - 'XPC_SERVICE_NAME': '0', 06:18:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:18:23 INFO - Installing collected packages: mozsystemmonitor 06:18:23 INFO - Running setup.py install for mozsystemmonitor 06:18:23 INFO - Successfully installed mozsystemmonitor 06:18:23 INFO - Cleaning up... 06:18:23 INFO - Return code: 0 06:18:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:18:23 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')]} 06:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:23 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')]} 06:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:23 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 0x10c212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd98a4ccc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0b6d30>, '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 0x10bf1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0adb20>, '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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 06:18:23 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 06:18:23 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 06:18:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W80Om5xNdd/Render', 06:18:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:23 INFO - 'HOME': '/Users/cltbld', 06:18:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:23 INFO - 'LOGNAME': 'cltbld', 06:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:23 INFO - 'MOZ_NO_REMOTE': '1', 06:18:23 INFO - 'NO_EM_RESTART': '1', 06:18:23 INFO - 'PAGER': '/bin/cat', 06:18:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:23 INFO - 'PWD': '/builds/slave/test', 06:18:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:23 INFO - 'SHELL': '/bin/bash', 06:18:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SmhZkZ1Td/Listeners', 06:18:23 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 06:18:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:23 INFO - 'USER': 'cltbld', 06:18:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:23 INFO - 'XPC_FLAGS': '0x0', 06:18:23 INFO - 'XPC_SERVICE_NAME': '0', 06:18:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:23 INFO - Downloading/unpacking blobuploader==1.2.4 06:18:23 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 06:18:23 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 06:18:23 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 06:18:23 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 06:18:23 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 06:18:23 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 06:18:26 INFO - Downloading blobuploader-1.2.4.tar.gz 06:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:18:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:18:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 INFO - Downloading docopt-0.6.1.tar.gz 06:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:18:27 INFO - Installing collected packages: blobuploader, requests, docopt 06:18:27 INFO - Running setup.py install for blobuploader 06:18:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:18:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:18:27 INFO - Running setup.py install for requests 06:18:28 INFO - Running setup.py install for docopt 06:18:28 INFO - Successfully installed blobuploader requests docopt 06:18:28 INFO - Cleaning up... 06:18:28 INFO - Return code: 0 06:18:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:28 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 0x10c212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd98a4ccc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0b6d30>, '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 0x10bf1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0adb20>, '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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 06:18:28 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 06:18:28 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 06:18:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W80Om5xNdd/Render', 06:18:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:28 INFO - 'HOME': '/Users/cltbld', 06:18:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:28 INFO - 'LOGNAME': 'cltbld', 06:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:28 INFO - 'MOZ_NO_REMOTE': '1', 06:18:28 INFO - 'NO_EM_RESTART': '1', 06:18:28 INFO - 'PAGER': '/bin/cat', 06:18:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:28 INFO - 'PWD': '/builds/slave/test', 06:18:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:28 INFO - 'SHELL': '/bin/bash', 06:18:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SmhZkZ1Td/Listeners', 06:18:28 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 06:18:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:28 INFO - 'USER': 'cltbld', 06:18:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:28 INFO - 'XPC_FLAGS': '0x0', 06:18:28 INFO - 'XPC_SERVICE_NAME': '0', 06:18:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-pGAiR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-fQVRft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-PAKcc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-7IIsl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-xPVNjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-5V8DxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8iJBEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-bJLzVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-2J_D5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-MPFbto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-OoqCvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:30 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-FFarZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:30 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-BChQ4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:30 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-m_4cKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:30 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-J7sWr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:30 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-SI2k6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:30 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-wxN7vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:18:30 INFO - Running setup.py install for manifestparser 06:18:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:18:30 INFO - Running setup.py install for mozcrash 06:18:30 INFO - Running setup.py install for mozdebug 06:18:31 INFO - Running setup.py install for mozdevice 06:18:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for mozfile 06:18:31 INFO - Running setup.py install for mozhttpd 06:18:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for mozinfo 06:18:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for mozInstall 06:18:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for mozleak 06:18:31 INFO - Running setup.py install for mozlog 06:18:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Running setup.py install for moznetwork 06:18:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Running setup.py install for mozprocess 06:18:32 INFO - Running setup.py install for mozprofile 06:18:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Running setup.py install for mozrunner 06:18:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Running setup.py install for mozscreenshot 06:18:32 INFO - Running setup.py install for moztest 06:18:33 INFO - Running setup.py install for mozversion 06:18:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:18:33 INFO - Cleaning up... 06:18:33 INFO - Return code: 0 06:18:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:33 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 0x10c212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd98a4ccc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0b6d30>, '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 0x10bf1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0adb20>, '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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 06:18:33 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 06:18:33 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 06:18:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W80Om5xNdd/Render', 06:18:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:33 INFO - 'HOME': '/Users/cltbld', 06:18:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:33 INFO - 'LOGNAME': 'cltbld', 06:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:33 INFO - 'MOZ_NO_REMOTE': '1', 06:18:33 INFO - 'NO_EM_RESTART': '1', 06:18:33 INFO - 'PAGER': '/bin/cat', 06:18:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:33 INFO - 'PWD': '/builds/slave/test', 06:18:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:33 INFO - 'SHELL': '/bin/bash', 06:18:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SmhZkZ1Td/Listeners', 06:18:33 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 06:18:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:33 INFO - 'USER': 'cltbld', 06:18:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:33 INFO - 'XPC_FLAGS': '0x0', 06:18:33 INFO - 'XPC_SERVICE_NAME': '0', 06:18:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-t8EfNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-y5196k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-lI9vfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-xFaBIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-oizBqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:34 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)) 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:34 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-qqwmNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:34 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)) 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:34 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-lNjO9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:34 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)) 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:34 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-kl44JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:34 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)) 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:34 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-CzVDSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:34 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)) 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:34 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-SuFKCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:34 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)) 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:34 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-gWShid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:34 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)) 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:34 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-kh_xG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:34 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)) 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:34 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-ihDd7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:34 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)) 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:34 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-fln7Ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:35 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-FJVWxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:35 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-1vaknl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:35 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-f9lzOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:35 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)) 06:18:35 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)) 06:18:35 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)) 06:18:35 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)) 06:18:35 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)) 06:18:35 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)) 06:18:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:37 INFO - Downloading blessings-1.6.tar.gz 06:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:18:37 INFO - Installing collected packages: blessings 06:18:37 INFO - Running setup.py install for blessings 06:18:38 INFO - Successfully installed blessings 06:18:38 INFO - Cleaning up... 06:18:38 INFO - Return code: 0 06:18:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:18:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:38 INFO - Reading from file tmpfile_stdout 06:18:38 INFO - Current package versions: 06:18:38 INFO - blessings == 1.6 06:18:38 INFO - blobuploader == 1.2.4 06:18:38 INFO - docopt == 0.6.1 06:18:38 INFO - manifestparser == 1.1 06:18:38 INFO - mozInstall == 1.12 06:18:38 INFO - mozcrash == 0.17 06:18:38 INFO - mozdebug == 0.1 06:18:38 INFO - mozdevice == 0.48 06:18:38 INFO - mozfile == 1.2 06:18:38 INFO - mozhttpd == 0.7 06:18:38 INFO - mozinfo == 0.9 06:18:38 INFO - mozleak == 0.1 06:18:38 INFO - mozlog == 3.1 06:18:38 INFO - moznetwork == 0.27 06:18:38 INFO - mozprocess == 0.22 06:18:38 INFO - mozprofile == 0.28 06:18:38 INFO - mozrunner == 6.11 06:18:38 INFO - mozscreenshot == 0.1 06:18:38 INFO - mozsystemmonitor == 0.0 06:18:38 INFO - moztest == 0.7 06:18:38 INFO - mozversion == 1.4 06:18:38 INFO - psutil == 3.1.1 06:18:38 INFO - requests == 1.2.3 06:18:38 INFO - wsgiref == 0.1.2 06:18:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:38 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 0x10c212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd98a4ccc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0b6d30>, '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 0x10bf1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0adb20>, '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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 06:18:38 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 06:18:38 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 06:18:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W80Om5xNdd/Render', 06:18:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:38 INFO - 'HOME': '/Users/cltbld', 06:18:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:38 INFO - 'LOGNAME': 'cltbld', 06:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:38 INFO - 'MOZ_NO_REMOTE': '1', 06:18:38 INFO - 'NO_EM_RESTART': '1', 06:18:38 INFO - 'PAGER': '/bin/cat', 06:18:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:38 INFO - 'PWD': '/builds/slave/test', 06:18:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:38 INFO - 'SHELL': '/bin/bash', 06:18:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SmhZkZ1Td/Listeners', 06:18:38 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 06:18:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:38 INFO - 'USER': 'cltbld', 06:18:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:38 INFO - 'XPC_FLAGS': '0x0', 06:18:38 INFO - 'XPC_SERVICE_NAME': '0', 06:18:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:38 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)) 06:18:38 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)) 06:18:38 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)) 06:18:38 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)) 06:18:38 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)) 06:18:38 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)) 06:18:38 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)) 06:18:38 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)) 06:18:38 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)) 06:18:38 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)) 06:18:38 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)) 06:18:38 INFO - Cleaning up... 06:18:38 INFO - Return code: 0 06:18:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:38 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 0x10c212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd98a4ccc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0b6d30>, '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 0x10bf1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0adb20>, '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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 06:18:38 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 06:18:38 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 06:18:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W80Om5xNdd/Render', 06:18:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:38 INFO - 'HOME': '/Users/cltbld', 06:18:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:38 INFO - 'LOGNAME': 'cltbld', 06:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:38 INFO - 'MOZ_NO_REMOTE': '1', 06:18:38 INFO - 'NO_EM_RESTART': '1', 06:18:38 INFO - 'PAGER': '/bin/cat', 06:18:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:38 INFO - 'PWD': '/builds/slave/test', 06:18:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:38 INFO - 'SHELL': '/bin/bash', 06:18:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SmhZkZ1Td/Listeners', 06:18:38 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 06:18:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:38 INFO - 'USER': 'cltbld', 06:18:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:38 INFO - 'XPC_FLAGS': '0x0', 06:18:38 INFO - 'XPC_SERVICE_NAME': '0', 06:18:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:38 INFO - Downloading/unpacking jsonschema 06:18:38 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 06:18:38 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 06:18:38 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 06:18:38 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 06:18:38 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 06:18:38 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 06:18:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:18:41 INFO - Downloading/unpacking functools32 (from jsonschema) 06:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:41 INFO - Downloading functools32-3.2.3-2.tar.gz 06:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:18:41 INFO - warning: no files found matching '*.txt' 06:18:41 INFO - no previously-included directories found matching 'build' 06:18:41 INFO - no previously-included directories found matching 'dist' 06:18:41 INFO - no previously-included directories found matching '.git*' 06:18:41 INFO - Installing collected packages: jsonschema, functools32 06:18:41 INFO - Running setup.py install for functools32 06:18:41 INFO - warning: no files found matching '*.txt' 06:18:41 INFO - no previously-included directories found matching 'build' 06:18:41 INFO - no previously-included directories found matching 'dist' 06:18:41 INFO - no previously-included directories found matching '.git*' 06:18:42 INFO - Successfully installed jsonschema functools32 06:18:42 INFO - Cleaning up... 06:18:42 INFO - Return code: 0 06:18:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:42 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 0x10c212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd98a4ccc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0b6d30>, '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 0x10bf1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0adb20>, '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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 06:18:42 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 06:18:42 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 06:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W80Om5xNdd/Render', 06:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:42 INFO - 'HOME': '/Users/cltbld', 06:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:42 INFO - 'LOGNAME': 'cltbld', 06:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:42 INFO - 'MOZ_NO_REMOTE': '1', 06:18:42 INFO - 'NO_EM_RESTART': '1', 06:18:42 INFO - 'PAGER': '/bin/cat', 06:18:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:42 INFO - 'PWD': '/builds/slave/test', 06:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:42 INFO - 'SHELL': '/bin/bash', 06:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SmhZkZ1Td/Listeners', 06:18:42 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 06:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:42 INFO - 'USER': 'cltbld', 06:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:42 INFO - 'XPC_FLAGS': '0x0', 06:18:42 INFO - 'XPC_SERVICE_NAME': '0', 06:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:42 INFO - Downloading/unpacking flake8 06:18:42 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 06:18:42 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 06:18:42 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 06:18:42 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 06:18:42 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 06:18:42 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 06:18:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:18:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:18:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:18:45 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 06:18:45 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 06:18:45 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 06:18:45 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 06:18:45 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 06:18:45 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 06:18:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:18:45 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 06:18:45 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 06:18:45 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 06:18:45 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 06:18:45 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 06:18:45 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 06:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:18:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:46 INFO - no previously-included directories found matching 'docs/_build' 06:18:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:18:46 INFO - Running setup.py install for pep8 06:18:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:46 INFO - no previously-included directories found matching 'docs/_build' 06:18:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:18:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:18:46 INFO - Cleaning up... 06:18:46 INFO - Return code: 0 06:18:46 INFO - Running post-action listener: _resource_record_post_action 06:18:46 INFO - Running post-action listener: _start_resource_monitoring 06:18:46 INFO - Starting resource monitoring. 06:18:46 INFO - ##### 06:18:46 INFO - ##### Running install step. 06:18:46 INFO - ##### 06:18:46 INFO - Running pre-action listener: _resource_record_pre_action 06:18:46 INFO - Running main action method: install 06:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:46 INFO - Reading from file tmpfile_stdout 06:18:46 INFO - Detecting whether we're running mozinstall >=1.0... 06:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:18:46 INFO - Reading from file tmpfile_stdout 06:18:46 INFO - Output received: 06:18:46 INFO - Usage: mozinstall [options] installer 06:18:46 INFO - Options: 06:18:46 INFO - -h, --help show this help message and exit 06:18:46 INFO - -d DEST, --destination=DEST 06:18:46 INFO - Directory to install application into. [default: 06:18:46 INFO - "/builds/slave/test"] 06:18:46 INFO - --app=APP Application being installed. [default: firefox] 06:18:46 INFO - mkdir: /builds/slave/test/build/application 06:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:19:09 INFO - Reading from file tmpfile_stdout 06:19:09 INFO - Output received: 06:19:09 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:19:09 INFO - Running post-action listener: _resource_record_post_action 06:19:09 INFO - ##### 06:19:09 INFO - ##### Running run-tests step. 06:19:09 INFO - ##### 06:19:09 INFO - Running pre-action listener: _resource_record_pre_action 06:19:09 INFO - Running main action method: run_tests 06:19:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:19:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:19:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:19:09 INFO - 2016-06-06 06:19:09.028 screenresolution[1650:8351] starting screenresolution argv=screenresolution get 06:19:09 INFO - 2016-06-06 06:19:09.030 screenresolution[1650:8351] Display 0: 1600x1200x32@60 06:19:09 INFO - 2016-06-06 06:19:09.036 screenresolution[1651:8353] starting screenresolution argv=screenresolution list 06:19:09 INFO - Available Modes on Display 0 06:19:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:19:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:19:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:19:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:19:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:19:09 INFO - Intel Iris: 06:19:09 INFO - Chipset Model: Intel Iris 06:19:09 INFO - Type: GPU 06:19:09 INFO - Bus: Built-In 06:19:09 INFO - VRAM (Dynamic, Max): 1536 MB 06:19:09 INFO - Vendor: Intel (0x8086) 06:19:09 INFO - Device ID: 0x0a2e 06:19:09 INFO - Revision ID: 0x0009 06:19:09 INFO - Displays: 06:19:09 INFO - Display: 06:19:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:19:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:19:09 INFO - Display Serial Number: 1600x1200 60 06:19:09 INFO - Main Display: Yes 06:19:09 INFO - Mirror: Off 06:19:09 INFO - Online: Yes 06:19:09 INFO - Rotation: Supported 06:19:09 INFO - Return code: 0 06:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:19:09 INFO - Python 2.7.3 06:19:09 INFO - Return code: 0 06:19:09 INFO - grabbing minidump binary from tooltool 06:19:09 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')]} 06:19:09 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 0x10c0b6d30>, '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 0x10bf1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0adb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:19:09 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 06:19:09 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 06:19:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:19:09 INFO - Return code: 0 06:19:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:19:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:19:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:19:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:19:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:19:10 INFO - Return code: 0 06:19:10 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/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 06:19:10 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/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --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 06:19:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W80Om5xNdd/Render', 06:19:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:10 INFO - 'HOME': '/Users/cltbld', 06:19:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:10 INFO - 'LOGNAME': 'cltbld', 06:19:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:19:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:10 INFO - 'MOZ_NO_REMOTE': '1', 06:19:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:19:10 INFO - 'NO_EM_RESTART': '1', 06:19:10 INFO - 'PAGER': '/bin/cat', 06:19:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:10 INFO - 'PWD': '/builds/slave/test', 06:19:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:19:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:10 INFO - 'SHELL': '/bin/bash', 06:19:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SmhZkZ1Td/Listeners', 06:19:10 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 06:19:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:10 INFO - 'USER': 'cltbld', 06:19:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:10 INFO - 'XPC_FLAGS': '0x0', 06:19:10 INFO - 'XPC_SERVICE_NAME': '0', 06:19:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:10 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/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 06:19:10 INFO - mozversion application_buildid: 20160602140837 06:19:10 INFO - mozversion application_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:19:10 INFO - mozversion application_display_name: Firefox 06:19:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:19:10 INFO - mozversion application_name: Firefox 06:19:10 INFO - mozversion application_remotingname: firefox 06:19:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:19:10 INFO - mozversion application_vendor: Mozilla 06:19:10 INFO - mozversion application_version: 47.0 06:19:10 INFO - mozversion platform_buildid: 20160602140837 06:19:10 INFO - mozversion platform_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:19:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:19:10 INFO - mozversion platform_version: 47.0 06:19:10 INFO - using testdate: 1465219150 06:19:10 INFO - actual date: 1465219150 06:19:10 INFO - starting webserver on 'localhost:49270' 06:19:10 INFO - SUITE-START | Running 2 tests 06:19:10 INFO - TEST-START | dromaeo_css 06:19:10 INFO - operating with platform_type : mac_ 06:19:10 INFO - Initialising browser for dromaeo_css test... 06:19:10 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmplmMN7C/profile http://localhost:49270/getInfo.html) 06:19:13 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 06:19:13 INFO - PROCESS | 1669 | colorDepth:24 06:19:13 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 06:19:13 INFO - PROCESS | 1669 | __metrics 06:19:13 INFO - PROCESS | 1669 | 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:19:13 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:13 INFO - TEST-INFO | 1669: exit 0 06:19:13 INFO - Browser initialized. 06:19:13 INFO - Running cycle 1/1 for dromaeo_css test... 06:19:13 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmplmMN7C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:25 INFO - PROCESS | 1673 | RSS: Main: 157057024 06:19:25 INFO - PROCESS | 1673 | 06:20:16 INFO - PROCESS | 1673 | 1465219216561 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:22:26 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 06:22:27 INFO - PROCESS | 1673 | RSS: Main: 299614208 06:22:27 INFO - PROCESS | 1673 | 06:25:30 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 06:25:30 INFO - PROCESS | 1673 | RSS: Main: 293593088 06:25:30 INFO - PROCESS | 1673 | 06:28:32 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 06:28:33 INFO - PROCESS | 1673 | RSS: Main: 301092864 06:28:33 INFO - PROCESS | 1673 | 06:31:34 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 06:31:35 INFO - PROCESS | 1673 | RSS: Main: 255119360 06:31:35 INFO - PROCESS | 1673 | 06:34:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 06:34:39 INFO - PROCESS | 1673 | RSS: Main: 257818624 06:34:39 INFO - PROCESS | 1673 | 06:37:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 06:37:41 INFO - PROCESS | 1673 | RSS: Main: 313012224 06:37:41 INFO - PROCESS | 1673 | 06:37:41 INFO - PROCESS | 1673 | __start_tp_report 06:37:41 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 06:37:41 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 06:37:41 INFO - PROCESS | 1673 | |i|pagename|runs| 06:37:41 INFO - PROCESS | 1673 | |0;dojo.html;3579.552555930509;3655.3420384330843;3663.67026967573;3670.8164591770405;3714.8699795507164;5898.434181131205;5908.645481271126;5910;5934.614250073742;5939.316978547468;5923.3484316725235;5953.553483488734;5953.791617293396;5970.761169553212;5979.372165922581;5235.973820130894;5327.520523152915;5349.919751203735;5379.757910894019;5424.240606315119;5406.783728650849;5425.891482170354;5434.049041417756;5436.456354364552;5437.809676661318;5266.7629956652045;5352.4915133062495;5371.650842695212;5389.649672771257;5423.078076726946;5394.541463975567;5402.432744561824;5430.619856610039;5439.211314359435;5490.835274941718;5188.247704082924;5361.463853614647;5369.892602147936;5380.973095134538;5381.5425688816495;5743.54051675865;5793.073108302651;5815.883682326372;5826.679532625704;5874.853128671817;6261.780837670705;6328.050792381134;6336.049592561107;6337.6197428154455;6338.809835704937;6252.624842509418;6259.561830671855;6261.123442718023;6299.905501417483;6330.208723909512;6032.276126864805;6069.393060693896;6078.6048906820915;6084.513238940918;6092.147099406086;6265.96867015662;6338.492920566344;6402.263739669905;6424.453921416639;6428.164338636041;6322.747090116436;6329.240491141092;6339.746410143543;6353.142325786052;6360.77737279193;6310.116583678288;6320.399562041599;6327.651979141099;6340;6343.207099112611;6262.342454042351;6280.340564240689;6352.745890164341;6355.269144048401;6362.013887847298;6213.937860621426;6256.5307601930035;6291.496680265568;6318;6318.020706790455;5046.596272298208;5073.365829271341;5081.3140226069745;5082.440931497532;5090.669106508065;4521.954780452219;4554.88612784683;4587.9082418351445;4608.078384323148;4616.8614941551805;6009.879802403927;6027.301887261676;6028.457438830438;6056.485198758155;6071.635701857903;6247.125402443661;6282.183316168869;6298.118263443122;6314.55798094129;6327.96836015817;6032.185654936615;6077.9392206078255;6080.483158931452;6080.969595151996;6084.452399284086;5538.44615538451;5558.416366281563;5559.138333558305;5565.916511252334;5578.470045345685;6323.146375239376;6341.143945567382;6420.775272865428;6423.96788016057;6511.641859697667;6273.874522509615;6281.560290779602;6282.2147231596055;6288.434040936338;6298.338674439118;6475.061116138228;6516.380943810331;6520.673966301761;6526.869462610816;6535.967320163369;6219.346968568235;6246.968765156327;6254.186955695731;6321.52588555851;6327.272363678236;6264.59280146789;6272.278687950944;6289.7484100635465;6297.716602752978;6309.589876658002;5340.706261155674;6117.279373342293;6278.529110316653;6293.559450838397;6294;6162.198914141133;6252.249730032425;6260.499160067275;6262;6266.686665666607;6116.082587611894;6150.876982460415;6175.876482470415;6191.84520386994;6192.659403732838;6151.292601350902;6200.844978875564;6256.906146407899;6297.622142671271;6319.368063193644;6141.486007784364;6181.505479561534;6185.6907154641185;6185.84535386619;6192.287886892885 06:37:41 INFO - PROCESS | 1673 | |1;ext.html;462.78711792575433;542.6038991536176;574.1674571870785;676.6973575866457;677.8508728079823;29506.85246573767;40185.79907100468;40607;40730.18539629206;40800.79599602002;43764.562354376445;43998.7800061;44147.558524414744;44206.55793442065;44318.77840610792;9707;9941.453220072894;9942.65200717975;9945.055219754147;9961.651342203024;9675.129238368545;9768.609255629803;9809.117179453848;9821.410715357102;9828.312018158731;8619.827603447928;9802.705918822447;9821.70534883951;9998.350107243043;10010.249231307645;8387.412881098326;8867.822643547157;9818.509074546315;9902.603895844193;9935.701928942144;9675.032496750338;9777.266704997153;9783.46190959497;9788.90211097887;9805.558749856202;43021.56978430207;43347.78326108381;43547.56452435467;43551.56448435507;43560.78219608913;3292.6378098409155;3343.481760327153;3379.0031940577587;3821.197548514815;4025.174839157995;29167.41665166706;30208.395832083235;30247.546286805715;30253.394932101233;30720;2793.385455199853;2818.689944106147;2822.4919514487383;2830.1226619747945;2896.2614533294086;505288;506472;506527.4673626645;507987;509162;69699;70217.94673079909;70402.29597703957;70485.64757176182;70615;75403.62298188474;77649;78631.60684196542;78840.81738773923;78936.81594776083;18969.956652383975;19223.711644325347;19228;19238.519037024187;19264.32574859873;14462.349194286282;14566.271686415637;14567.41730330775;14579.41682332716;14589.489367872286;22375.88812055929;22670.433239169153;22678.886605566866;22692.432689182573;22736.43158921007;9298.163165315154;9528.714138575853;9550.474723890115;9567.234621230285;9582.472963986907;966.5602151021268;1070.710908054821;1087.3732269194527;1104.9779004420027;1112.2047735868894;30632.84683576568;30664.84667576648;31046.22384440407;31138;31351.529727054112;1144.5307423956137;1180.698921774942;1185.697647099984;1218.4273391506156;1257.0383656502784;15384.461543845911;15669.843301567067;15843.683126337408;15844.253682520062;15942.28259728315;563333;568725;570127;572683;572723;62588;63024.054639180446;63180.052299215546;63346.68326658337;63372.36627633757;1446.5298777897226;1557.961050973712;1562.211083402897;1587.777711120444;1595.8244593094983;29059.12822615325;29487.378194198667;29600.703992959796;29684.40631187321;30086;48294.03411931671;48827.26759098545;48846;48904.75547622239;48910;324228;325277;325789;326048;326772;30289.697103028688;48317.03365932732;48985;49466.75266623644;49923.001539968274;47693.52306476891;47830.760846195546;47888.521114788404;48352.758236208596;49683.254751179484;37365;37963.62036379711;38313.233735325695;38455.423168653055;39298.410523841594;37469.43795843119;37524.249515010095;38128.428073579475;38235;39121.804390977864;40127.39808902927;40195.79902100471;40753;41375.58624413717;41418.792906036484;34644.48033279553;35187;35886.10284742902;36055.27889442249;36187.276254474236;21763.891180543997;26165.607515886895;26612.60081098824;26779;27059.323516912234 06:37:41 INFO - PROCESS | 1673 | |2;jquery.html;386.81046287319214;390.2760379496037;392.45252872243213;395.8812356293111;400.4333867577378;19971.900140499296;21026.579468410622;21159.894200529016;21438.89280553595;21465.892670536647;21694.240701575447;21766.673499897475;22418;22426.88786556069;22604.54790904181;5886.234789477362;6005.279366476029;6080.179175811253;6098.420650038262;6102.023676211807;5860.208871802295;6002.3697511761075;6022.337542870281;6039.335673075958;6062.757489700407;5804.622699524539;6008.3390827009;6013.579049466539;6024.126501657257;6046.848828779272;5950.523958083343;5969.970150149265;6011.2786465624185;6015.789447369343;6018.8495287617725;5652.208690783294;5661.377248502661;5688.886222275572;5711.200431939532;5725.513331366838;13790;14165.78751318731;14276.500322488662;14314.785278220836;14354.856451435457;1771.929122835085;1880.1539307311764;2044.366246463601;2392.12687369109;2809.987304274224;8650.39967605995;9813.558389872473;9944.105030547285;10200.540975656113;10725.30285531438;1720.7676963609877;1732.3763445159732;1737.37454516374;1745.179765510221;1772.3087995681694;78150.21849781543;109215;111068;115991;117829.41085294605;9936.453495057696;10477.9476102619;11591.594294199662;11657.650270491898;11751.294922304689;14456.85543144555;14464.493742719165;14470.842332613365;14488.34802433893;14524.564263072125;9023.729288121367;9143.862842057375;9155.725328240163;9214.90785092154;9239.122283383067;9466.479343636029;9468.431894086378;9485.857712134324;9494.810103797885;9579.712608621752;4466.330050492452;4543.7728113594185;4554;4558;4604.194266003436;1627.4466681328406;1915.8658893877296;1921.788603253641;1924.4034349351746;1973.181129831104;931.4504442379028;960.4813400763649;974.6247694637474;1008.9899101008896;1030.4950574218728;20477.283295084602;20599.4850128745;20636;20643.69034464484;20880;1036.3419228789621;1039.2361614213546;1067.9252452328417;1071.6624263357019;1084.3493903657743;10974.122070234362;11333.036691881283;11379.886201138048;11388.202825802115;11397.145214108976;650037;657104;688739;689606;695326;82289;113926;120672.396638018;141057.8841317381;143166;1061.7823346214007;1089.9128069754402;1090.5801266512292;1093.2620481175175;1094.8412480190486;18265.634687306447;18727.438176854717;19022.7146592804;19093.236270549023;19380.93404862746;32882.50676239906;34939.65060349364;54911;55609.60975975633;58989;78522.42955140979;79032;80537;80755;82367.17632823595;6901.378875901193;7158.785236442915;8157.1842815717955;8160;8215.548144852091;11925.880741192477;12836.358182091044;13009.674758131123;13229.140105893086;13280.734385312433;11022.50398732075;11085.334879907232;11301.321920684784;11347.943260283646;11514.021308188898;9838.557264923238;10565.947170264408;10619.628313009007;11243.381614011309;11627;9984.500774961369;10245.74385640365;10919.290246133976;11517.021053210236;11578.073754099483;7875.527468351917;7880.975473188449;8091.433599647969;8164.795880102807;8180.754577362689;9748.122668959828;11227.719307017063;11282.323060616389;11336.6032188873;11374.94312528432 06:37:41 INFO - PROCESS | 1673 | |3;mootools.html;1496.5809573319461;1634.1339090282152;1656.320908427545;1976.8912709800964;2065.0707181768207;8191.3856460765455;8921.955390223047;9074.274058075354;9082.591283392247;9108.81782364353;8717.825643487127;9013.233875120606;9015.774605634862;9020.684276050339;9067.818643627124;2152.9892350538303;2553.770160685538;2585.58630619101;2589.2361753282826;2592.8055395845295;2480.131953816159;2588.598767191079;2589.4303253284247;2590.5337039332912;2601.6747906511687;2546.9235922922344;2566.9218928050173;2577.8453292802396;2585.418280886804;2590.766830985211;2125.787421257877;2530.367408147963;2539.898404063835;2540.428403609173;2580.380708629934;2538.923832285034;2542.300867261518;2542.720300766914;2545;2596.9741951929072;9072.410293330913;9188.586513606904;9192.310576706706;9205.723828285161;9207.585658645377;5589.860253493654;5775.162601422812;5783.277090363705;5785.479306862402;5800.100984347433;3613.114786877232;3669.1377526281303;3743.9812800936093;3758.248350329945;3784.791836448994;1053.4837929414532;1071.9464026798628;1073.5652060915343;1086.8369744538304;1107.053469283759;12225.327606981613;12384.071194660346;12388.752224955451;12415.379231038412;12434.440450179764;4989.501049894981;4990.800367985313;5047.671901326402;5049.82325618609;5049.92952889321;10414.583416663248;10443.582256709646;10457.477126143662;10460.895391046144;10491.632792852213;5691.317041954909;5701.059325211294;5703.344115426779;5742.28221472316;5743.798967036134;4686.95313046872;4867.951320486821;5008.649394542347;5152.562032227228;5214.2960700304975;3964.4053391991433;3998.9400158997637;4039.8586049488713;4065.4511640928686;4078.8164532596106;1341.6176389729076;1354.228089988697;1358.1647286918671;1368.1244003837553;1371.1978492581752;1312.1471043821593;1442.1923722715312;1465.3186268385039;1465.5383554180398;1466.8533146685247;8405.159484051546;8473.406861519634;8524.616392262238;8541.359398045171;8550.828983420297;532.8268312798278;543.5760107116455;543.9347278326547;554.9944500554943;555.2698201864536;6328.6835658216905;6331.873362532723;6355.936440635627;6363.681815909186;6378.744850206032;10803.83794243087;11192.944035279772;11323.94338028321;11325.603603873826;11329;8961.417507861968;10632.149428045737;11021.944890275498;11066.059384952368;11083.445827708743;6978.720851165896;8557.10150434208;8594;8672;8681.956590217009;8090.312323452573;8099.797505062184;8214.178582141738;8277.917220827956;8382.161783821814;9594.856077158709;9762.511874406393;9887.604495820375;9914.504274786375;9930.801383972424;9866.556004979937;10136.94931525367;10266.897331026892;10336.586536538754;10339.896601034194;7577.507462014952;7603.505772124794;7622.16156222804;7705;7717.922820771945;8501.234888860032;8525.275351594935;8572.78568035779;8598.140185981352;8606.44058136219;7562.395008399205;7721.150673425806;7767.844643106993;7779.37764978789;7814.101378341564;7511.248875112445;7527.473076884566;7595.734149304748;7664.846703065796;7684;8087.353011759163;8170.714025009096;8180.263776260165;8181.754547363588;8185.631646576037;7238.927610723826;7387.667554959932;7400.962995184989;7416.629168541659;7416.66625001887;6169.753209871555;7491.925080749123;7503.437242206747;7507.249275072449;7514.661840217313 06:37:41 INFO - PROCESS | 1673 | |4;prototype.html;333.9448990916499;340.75125158634194;344.03841263668045;344.5658470327387;349.46357341480814;6477.384648458401;6480.31956644552;6514.511411644122;6527.575707579004;6538.150040494741;6410.743570257196;6439.356064393558;6457.967710161454;6464.028471316246;6469.902951455732;4643.698159619631;4732.124556956974;4770.4275486941615;4886.413630364353;4892.461829198803;4848.7575621218975;4880.194767863299;4890.828820991266;4895.9755201224125;4903.4606193318705;4821.108095002418;4821.7830197641015;4826.927596086061;4831.492693267209;4843.39457567804;4592.632589392841;4693.859184224461;4791.041791641685;4805.111054454902;4821.831235906761;4130.339145736698;4135.462389889325;4135.77253251071;4143.647789937859;4160.2303573838635;6111.816645500598;6124.173236613089;6128.479079278267;6147.293061297919;6150.261968563801;5585.2459917910965;5597.44025597441;5603.879224155145;5606.878624275161;5610.102383618642;6786.321367863224;6786.8303292417595;6788.456923446112;6794.3545363190415;6802.2857599951785;4571.1771881061395;4709.387779588632;4729.645276604234;4733.219018861883;4735.810567577293;6969.546979446371;7088.255733148048;7272.16370117438;7316.780496585057;7326.890096648554;4157.667386609064;4821.252705830602;4826.131296366688;4827.324174615486;4838.346823178897;4884.609231261491;4885.780139893643;4889.242167464049;4895.922896962663;4911.901761964741;4919.655624106278;5500.917486237709;5734.913976290359;5736.713164341766;5744.788256521186;6636.734530618721;6833.180018397824;6858.862822743517;6877.071595334566;6961.164660240804;1661.950141495757;1680.5210515003166;1680.7142785726455;1690.9661806763795;1693.4750227429536;908.4821651658623;1045.592219034577;1075.3762817565948;1102.151343465543;1126.4255229832845;5061.392632884077;6248.31268560458;6258.15514905491;6377.139086223393;6556.27880933097;6112.8777424452155;6497.902531462032;6942.548734332252;7204.13550373948;7214.67533960973;6499.382558657015;6502.934970650327;6504.089427480157;6515.250746164157;6521.967390163114;3746.925061498755;3793.829277682511;3795.18403543234;3797.981010094987;3799.1072098056934;7268.491205615662;7496.287852653989;7534.133574638987;7543.321101100927;7574.431917606202;7330.560166390033;7391.8152046199275;7397.556146631219;7402.629868506553;7410.296021877913;7500.812479687942;7506.28690274423;7511.211322811136;7525.774226773206;7542.698292068475;6977.6264591439685;7183.712651493882;7189.856202876018;7195.496315257882;7196.604186769778;6940.514164008673;7047.894281585678;7047.929520704727;7061.046758687511;7085.256048114874;7462.813429664302;7479.626018699152;7492.587907665131;7494.288042635941;7510.009847390336;4791.592714619296;4798.136335459651;4807.18277892766;4807.375041244616;4808.014357056725;7112.893306600302;7121.750738724119;7127.928720712726;7130.429565634633;7130.5365151265005;5764.625299355528;6664.83337916556;6714.3957043866285;6905.620190889549;6943.305669433218;6838.879947216379;6882.7591034313555;6885.965570172117;6891.173059232924;6907.378335949788;5406.729663516887;6713.56361836479;6724.058631791651;6729.360710732472;6738.561993470409;5513.917291240555;6890.724371025103;6907.965460172667;6917.550359226634;6921.93078069233;6544.411003009752;6668.499862510428;6752.8649427010205;6766.4248538874745;6766.86466270662 06:37:41 INFO - PROCESS | 1673 | |5;yui.html;659.8449364399365;700.4361489001355;775.1783109903506;790.9129995700474;801.4550105927968;15416.999999999985;15614.29735661895;15642;15647.921760391211;15663.21683915804;14407.711845763079;14448.566543003726;14465;14467.710645787078;14507.564773056825;793.0364607002491;816.9714060007901;967.4630580028081;995.4972738766912;996.6063404955038;965.1313817564178;975.9316847820655;976.4483067067084;981.8085473332703;981.9836469254324;850.1625898489982;1045.8483519889612;1050.831866901296;1051.2063392138925;1052.2686732720763;1026.255964425789;1050.7163065972145;1052.4001319247993;1053.6312290698195;1053.815582273103;653.4739534674585;781.3631890009624;782.8943092682472;783.7139444102918;785.7721260834351;12358.258504489759;14901.776473352907;15192.936494445394;15371.154586497738;15442.536723898302;12878.80681789774;12880.935595321964;13131.474741010348;13461.865381346159;13478.865211347858;9515.762105947337;11407.030402415805;11582.47878845454;11850.88149118515;11949.22330048544;3639.508666330038;3670.8164591770305;3700.8704695335805;3736.17804083104;3929.292727309083;79963.8005429919;84227.15772842316;85078.29843403159;85308.29383412359;85538.14461855363;9826.164775993977;10213.846792298122;10281.94859025715;10301.433421161908;10468.947655261674;23901;24238.272851814472;24246.87876560606;24256.514869702507;24323.027078917;6643.435307998778;7937;7965.840683186304;8120.6345714443;8271.379646526535;3726.9813650932115;3960.8019599019935;4108.705757686319;4244.702870799015;4305.246581848164;3718.1076541629814;3753.0242137044565;3776.86780962665;3814;3814.904627384338;596.5317225977586;662.7216569041015;675.8580698053464;709.9467539934526;715.770953294951;551.5807985930721;563.9125935480007;590.630855715178;593.1902952469848;631.8388810853295;8007.599620018976;8426.578671066422;8549.743507694779;8669.26311263537;8853.335999799912;550.9669419834822;589.5313225985352;612.3203244398713;636.4685487617799;640.4748106552676;3247.935041299208;3860.3630400983525;3962.5244970603712;4001.2197621463533;4007.1785284016705;91843.62234566487;92622.53688731513;97709.25198228189;97923;98787.51818722725;80885.59557202176;81215;85563;87353.56323218471;88038.11961880299;73636.89544656835;75040.87438688424;76127.61936190283;76518.81144724102;77248.91869370312;6685.264620891795;7363.300486453778;7382.151052628801;7989.241022102891;8246.216609422096;53027.20459193038;53185.46814531805;53243;53330.73334633302;53762.04308762899;66732;70405;73059.53880922246;74362;76775.61612191904;10248.128909042516;10578.100861426865;10655.89344106549;10660.84008739885;11261.493232804707;10778.191635627203;10971;11003;11120.388378639253;11350.148738844784;10527.420991845522;10842.457877106272;10876.836847447454;10907.509162087883;11067.612633557786;10374.896251037695;10526.52630631608;10583.253763128998;10685.252032357661;10750.408727520062;10340.793184136124;10464.372137671764;10584.89415105839;10656.786864262516;10846;8678.958127135606;8800.207981281716;8873.023967363455;9033.187013168847;9159.725208243763;8992.86510702353;9057.68298109563;9103.772405689911;9185.081491850762;9246 06:37:41 INFO - PROCESS | 1673 | __end_tp_report 06:37:41 INFO - PROCESS | 1673 | __start_cc_report 06:37:41 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1207 06:37:41 INFO - PROCESS | 1673 | __end_cc_report 06:37:41 INFO - PROCESS | 1673 | __startTimestamp1465220261872__endTimestamp 06:37:41 INFO - PROCESS | 1673 | 06:37:41 INFO - PROCESS | 1673 | ------- Summary: start ------- 06:37:41 INFO - PROCESS | 1673 | Number of tests: 6 06:37:41 INFO - PROCESS | 1673 | 06:37:41 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5904.04 Median:6175.88 stddev:607.00 (9.8%) stddev-sans-first:580.83 06:37:41 INFO - PROCESS | 1673 | Values: 3579.6 3655.3 3663.7 3670.8 3714.9 5898.4 5908.6 5910.0 5934.6 5939.3 5923.3 5953.6 5953.8 5970.8 5979.4 5236.0 5327.5 5349.9 5379.8 5424.2 5406.8 5425.9 5434.0 5436.5 5437.8 5266.8 5352.5 5371.7 5389.6 5423.1 5394.5 5402.4 5430.6 5439.2 5490.8 5188.2 5361.5 5369.9 5381.0 5381.5 5743.5 5793.1 5815.9 5826.7 5874.9 6261.8 6328.1 6336.0 6337.6 6338.8 6252.6 6259.6 6261.1 6299.9 6330.2 6032.3 6069.4 6078.6 6084.5 6092.1 6266.0 6338.5 6402.3 6424.5 6428.2 6322.7 6329.2 6339.7 6353.1 6360.8 6310.1 6320.4 6327.7 6340.0 6343.2 6262.3 6280.3 6352.7 6355.3 6362.0 6213.9 6256.5 6291.5 6318.0 6318.0 5046.6 5073.4 5081.3 5082.4 5090.7 4522.0 4554.9 4587.9 4608.1 4616.9 6009.9 6027.3 6028.5 6056.5 6071.6 6247.1 6282.2 6298.1 6314.6 6328.0 6032.2 6077.9 6080.5 6081.0 6084.5 5538.4 5558.4 5559.1 5565.9 5578.5 6323.1 6341.1 6420.8 6424.0 6511.6 6273.9 6281.6 6282.2 6288.4 6298.3 6475.1 6516.4 6520.7 6526.9 6536.0 6219.3 6247.0 6254.2 6321.5 6327.3 6264.6 6272.3 6289.7 6297.7 6309.6 5340.7 6117.3 6278.5 6293.6 6294.0 6162.2 6252.2 6260.5 6262.0 6266.7 6116.1 6150.9 6175.9 6191.8 6192.7 6151.3 6200.8 6256.9 6297.6 6319.4 6141.5 6181.5 6185.7 6185.8 6192.3 06:37:41 INFO - PROCESS | 1673 | 06:37:41 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:63660.90 Median:40668.59 stddev:127278.47 (313.0%) stddev-sans-first:127547.07 06:37:41 INFO - PROCESS | 1673 | Values: 462.8 542.6 574.2 676.7 677.9 29506.9 40185.8 40607.0 40730.2 40800.8 43764.6 43998.8 44147.6 44206.6 44318.8 9707.0 9941.5 9942.7 9945.1 9961.7 9675.1 9768.6 9809.1 9821.4 9828.3 8619.8 9802.7 9821.7 9998.4 10010.2 8387.4 8867.8 9818.5 9902.6 9935.7 9675.0 9777.3 9783.5 9788.9 9805.6 43021.6 43347.8 43547.6 43551.6 43560.8 3292.6 3343.5 3379.0 3821.2 4025.2 29167.4 30208.4 30247.5 30253.4 30720.0 2793.4 2818.7 2822.5 2830.1 2896.3 505288.0 506472.0 506527.5 507987.0 509162.0 69699.0 70217.9 70402.3 70485.6 70615.0 75403.6 77649.0 78631.6 78840.8 78936.8 18970.0 19223.7 19228.0 19238.5 19264.3 14462.3 14566.3 14567.4 14579.4 14589.5 22375.9 22670.4 22678.9 22692.4 22736.4 9298.2 9528.7 9550.5 9567.2 9582.5 966.6 1070.7 1087.4 1105.0 1112.2 30632.8 30664.8 31046.2 31138.0 31351.5 1144.5 1180.7 1185.7 1218.4 1257.0 15384.5 15669.8 15843.7 15844.3 15942.3 563333.0 568725.0 570127.0 572683.0 572723.0 62588.0 63024.1 63180.1 63346.7 63372.4 1446.5 1558.0 1562.2 1587.8 1595.8 29059.1 29487.4 29600.7 29684.4 30086.0 48294.0 48827.3 48846.0 48904.8 48910.0 324228.0 325277.0 325789.0 326048.0 326772.0 30289.7 48317.0 48985.0 49466.8 49923.0 47693.5 47830.8 47888.5 48352.8 49683.3 37365.0 37963.6 38313.2 38455.4 39298.4 37469.4 37524.2 38128.4 38235.0 39121.8 40127.4 40195.8 40753.0 41375.6 41418.8 34644.5 35187.0 35886.1 36055.3 36187.3 21763.9 26165.6 26612.6 26779.0 27059.3 06:37:41 INFO - PROCESS | 1673 | 06:37:41 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:36357.95 Median:21580.07 stddev:111977.55 (518.9%) stddev-sans-first:112259.10 06:37:41 INFO - PROCESS | 1673 | Values: 386.8 390.3 392.5 395.9 400.4 19971.9 21026.6 21159.9 21438.9 21465.9 21694.2 21766.7 22418.0 22426.9 22604.5 5886.2 6005.3 6080.2 6098.4 6102.0 5860.2 6002.4 6022.3 6039.3 6062.8 5804.6 6008.3 6013.6 6024.1 6046.8 5950.5 5970.0 6011.3 6015.8 6018.8 5652.2 5661.4 5688.9 5711.2 5725.5 13790.0 14165.8 14276.5 14314.8 14354.9 1771.9 1880.2 2044.4 2392.1 2810.0 8650.4 9813.6 9944.1 10200.5 10725.3 1720.8 1732.4 1737.4 1745.2 1772.3 78150.2 109215.0 111068.0 115991.0 117829.4 9936.5 10477.9 11591.6 11657.7 11751.3 14456.9 14464.5 14470.8 14488.3 14524.6 9023.7 9143.9 9155.7 9214.9 9239.1 9466.5 9468.4 9485.9 9494.8 9579.7 4466.3 4543.8 4554.0 4558.0 4604.2 1627.4 1915.9 1921.8 1924.4 1973.2 931.5 960.5 974.6 1009.0 1030.5 20477.3 20599.5 20636.0 20643.7 20880.0 1036.3 1039.2 1067.9 1071.7 1084.3 10974.1 11333.0 11379.9 11388.2 11397.1 650037.0 657104.0 688739.0 689606.0 695326.0 82289.0 113926.0 120672.4 141057.9 143166.0 1061.8 1089.9 1090.6 1093.3 1094.8 18265.6 18727.4 19022.7 19093.2 19380.9 32882.5 34939.7 54911.0 55609.6 58989.0 78522.4 79032.0 80537.0 80755.0 82367.2 6901.4 7158.8 8157.2 8160.0 8215.5 11925.9 12836.4 13009.7 13229.1 13280.7 11022.5 11085.3 11301.3 11347.9 11514.0 9838.6 10565.9 10619.6 11243.4 11627.0 9984.5 10245.7 10919.3 11517.0 11578.1 7875.5 7881.0 8091.4 8164.8 8180.8 9748.1 11227.7 11282.3 11336.6 11374.9 06:37:41 INFO - PROCESS | 1673 | 06:37:41 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:6258.63 Median:549.46 stddev:3308.88 (602.2%) stddev-sans-first:3298.80 06:37:41 INFO - PROCESS | 1673 | Values: 1496.6 1634.1 1656.3 1976.9 2065.1 8191.4 8922.0 9074.3 9082.6 9108.8 8717.8 9013.2 9015.8 9020.7 9067.8 2153.0 2553.8 2585.6 2589.2 2592.8 2480.1 2588.6 2589.4 2590.5 2601.7 2546.9 2566.9 2577.8 2585.4 2590.8 2125.8 2530.4 2539.9 2540.4 2580.4 2538.9 2542.3 2542.7 2545.0 2597.0 9072.4 9188.6 9192.3 9205.7 9207.6 5589.9 5775.2 5783.3 5785.5 5800.1 3613.1 3669.1 3744.0 3758.2 3784.8 1053.5 1071.9 1073.6 1086.8 1107.1 12225.3 12384.1 12388.8 12415.4 12434.4 4989.5 4990.8 5047.7 5049.8 5049.9 10414.6 10443.6 10457.5 10460.9 10491.6 5691.3 5701.1 5703.3 5742.3 5743.8 4687.0 4868.0 5008.6 5152.6 5214.3 3964.4 3998.9 4039.9 4065.5 4078.8 1341.6 1354.2 1358.2 1368.1 1371.2 1312.1 1442.2 1465.3 1465.5 1466.9 8405.2 8473.4 8524.6 8541.4 8550.8 532.8 543.6 543.9 555.0 555.3 6328.7 6331.9 6355.9 6363.7 6378.7 10803.8 11192.9 11323.9 11325.6 11329.0 8961.4 10632.1 11021.9 11066.1 11083.4 6978.7 8557.1 8594.0 8672.0 8682.0 8090.3 8099.8 8214.2 8277.9 8382.2 9594.9 9762.5 9887.6 9914.5 9930.8 9866.6 10136.9 10266.9 10336.6 10339.9 7577.5 7603.5 7622.2 7705.0 7717.9 8501.2 8525.3 8572.8 8598.1 8606.4 7562.4 7721.2 7767.8 7779.4 7814.1 7511.2 7527.5 7595.7 7664.8 7684.0 8087.4 8170.7 8180.3 8181.8 8185.6 7238.9 7387.7 7401.0 7416.6 7416.7 6169.8 7491.9 7503.4 7507.2 7514.7 06:37:41 INFO - PROCESS | 1673 | 06:37:41 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5672.92 Median:6466.97 stddev:1768.25 (27.3%) stddev-sans-first:1727.21 06:37:41 INFO - PROCESS | 1673 | Values: 333.9 340.8 344.0 344.6 349.5 6477.4 6480.3 6514.5 6527.6 6538.2 6410.7 6439.4 6458.0 6464.0 6469.9 4643.7 4732.1 4770.4 4886.4 4892.5 4848.8 4880.2 4890.8 4896.0 4903.5 4821.1 4821.8 4826.9 4831.5 4843.4 4592.6 4693.9 4791.0 4805.1 4821.8 4130.3 4135.5 4135.8 4143.6 4160.2 6111.8 6124.2 6128.5 6147.3 6150.3 5585.2 5597.4 5603.9 5606.9 5610.1 6786.3 6786.8 6788.5 6794.4 6802.3 4571.2 4709.4 4729.6 4733.2 4735.8 6969.5 7088.3 7272.2 7316.8 7326.9 4157.7 4821.3 4826.1 4827.3 4838.3 4884.6 4885.8 4889.2 4895.9 4911.9 4919.7 5500.9 5734.9 5736.7 5744.8 6636.7 6833.2 6858.9 6877.1 6961.2 1662.0 1680.5 1680.7 1691.0 1693.5 908.5 1045.6 1075.4 1102.2 1126.4 5061.4 6248.3 6258.2 6377.1 6556.3 6112.9 6497.9 6942.5 7204.1 7214.7 6499.4 6502.9 6504.1 6515.3 6522.0 3746.9 3793.8 3795.2 3798.0 3799.1 7268.5 7496.3 7534.1 7543.3 7574.4 7330.6 7391.8 7397.6 7402.6 7410.3 7500.8 7506.3 7511.2 7525.8 7542.7 6977.6 7183.7 7189.9 7195.5 7196.6 6940.5 7047.9 7047.9 7061.0 7085.3 7462.8 7479.6 7492.6 7494.3 7510.0 4791.6 4798.1 4807.2 4807.4 4808.0 7112.9 7121.8 7127.9 7130.4 7130.5 5764.6 6664.8 6714.4 6905.6 6943.3 6838.9 6882.8 6886.0 6891.2 6907.4 5406.7 6713.6 6724.1 6729.4 6738.6 5513.9 6890.7 6908.0 6917.6 6921.9 6544.4 6668.5 6752.9 6766.4 6766.9 06:37:41 INFO - PROCESS | 1673 | 06:37:41 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:19098.41 Median:53546.39 stddev:27334.84 (51.0%) stddev-sans-first:27376.46 06:37:41 INFO - PROCESS | 1673 | Values: 659.8 700.4 775.2 790.9 801.5 15417.0 15614.3 15642.0 15647.9 15663.2 14407.7 14448.6 14465.0 14467.7 14507.6 793.0 817.0 967.5 995.5 996.6 965.1 975.9 976.4 981.8 982.0 850.2 1045.8 1050.8 1051.2 1052.3 1026.3 1050.7 1052.4 1053.6 1053.8 653.5 781.4 782.9 783.7 785.8 12358.3 14901.8 15192.9 15371.2 15442.5 12878.8 12880.9 13131.5 13461.9 13478.9 9515.8 11407.0 11582.5 11850.9 11949.2 3639.5 3670.8 3700.9 3736.2 3929.3 79963.8 84227.2 85078.3 85308.3 85538.1 9826.2 10213.8 10281.9 10301.4 10468.9 23901.0 24238.3 24246.9 24256.5 24323.0 6643.4 7937.0 7965.8 8120.6 8271.4 3727.0 3960.8 4108.7 4244.7 4305.2 3718.1 3753.0 3776.9 3814.0 3814.9 596.5 662.7 675.9 709.9 715.8 551.6 563.9 590.6 593.2 631.8 8007.6 8426.6 8549.7 8669.3 8853.3 551.0 589.5 612.3 636.5 640.5 3247.9 3860.4 3962.5 4001.2 4007.2 91843.6 92622.5 97709.3 97923.0 98787.5 80885.6 81215.0 85563.0 87353.6 88038.1 73636.9 75040.9 76127.6 76518.8 77248.9 6685.3 7363.3 7382.2 7989.2 8246.2 53027.2 53185.5 53243.0 53330.7 53762.0 66732.0 70405.0 73059.5 74362.0 76775.6 10248.1 10578.1 10655.9 10660.8 11261.5 10778.2 10971.0 11003.0 11120.4 11350.1 10527.4 10842.5 10876.8 10907.5 11067.6 10374.9 10526.5 10583.3 10685.3 10750.4 10340.8 10464.4 10584.9 10656.8 10846.0 8679.0 8800.2 8873.0 9033.2 9159.7 8992.9 9057.7 9103.8 9185.1 9246.0 06:37:41 INFO - PROCESS | 1673 | -------- Summary: end -------- 06:37:41 INFO - PROCESS | 1673 | 06:37:42 INFO - TEST-INFO | 1673: exit 0 06:37:42 INFO - TEST-OK | dromaeo_css | took 1111618ms 06:37:42 INFO - TEST-START | kraken 06:37:42 INFO - operating with platform_type : mac_ 06:37:42 INFO - Initialising browser for kraken test... 06:37:42 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpFibAFl/profile http://localhost:49270/getInfo.html) 06:37:44 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 06:37:44 INFO - PROCESS | 1679 | colorDepth:24 06:37:44 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 06:37:44 INFO - PROCESS | 1679 | __metrics 06:37:44 INFO - PROCESS | 1679 | 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:37:44 INFO - PROCESS | 1679 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:37:45 INFO - TEST-INFO | 1679: exit 0 06:37:45 INFO - Browser initialized. 06:37:45 INFO - Running cycle 1/1 for kraken test... 06:37:45 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpFibAFl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:57 INFO - PROCESS | 1682 | RSS: Main: 156741632 06:37:57 INFO - PROCESS | 1682 | 06:37:59 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:00 INFO - PROCESS | 1682 | RSS: Main: 217636864 06:38:00 INFO - PROCESS | 1682 | 06:38:02 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 06:38:03 INFO - PROCESS | 1682 | RSS: Main: 227962880 06:38:03 INFO - PROCESS | 1682 | 06:38:06 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 06:38:07 INFO - PROCESS | 1682 | RSS: Main: 217755648 06:38:07 INFO - PROCESS | 1682 | 06:38:09 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 06:38:09 INFO - PROCESS | 1682 | RSS: Main: 218947584 06:38:09 INFO - PROCESS | 1682 | 06:38:12 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:38:12 INFO - PROCESS | 1682 | RSS: Main: 219807744 06:38:12 INFO - PROCESS | 1682 | 06:38:15 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 06:38:15 INFO - PROCESS | 1682 | RSS: Main: 219635712 06:38:15 INFO - PROCESS | 1682 | 06:38:18 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:19 INFO - PROCESS | 1682 | RSS: Main: 219762688 06:38:19 INFO - PROCESS | 1682 | 06:38:22 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 06:38:22 INFO - PROCESS | 1682 | RSS: Main: 219992064 06:38:22 INFO - PROCESS | 1682 | 06:38:24 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:24 INFO - PROCESS | 1682 | RSS: Main: 255918080 06:38:24 INFO - PROCESS | 1682 | 06:38:26 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:27 INFO - PROCESS | 1682 | RSS: Main: 256995328 06:38:27 INFO - PROCESS | 1682 | 06:38:29 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:29 INFO - PROCESS | 1682 | RSS: Main: 260861952 06:38:29 INFO - PROCESS | 1682 | 06:38:32 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:33 INFO - PROCESS | 1682 | RSS: Main: 262230016 06:38:33 INFO - PROCESS | 1682 | 06:38:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:36 INFO - PROCESS | 1682 | RSS: Main: 262324224 06:38:36 INFO - PROCESS | 1682 | 06:38:37 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 06:38:38 INFO - PROCESS | 1682 | RSS: Main: 325074944 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | __start_tp_report 06:38:38 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 06:38:38 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 06:38:38 INFO - PROCESS | 1682 | |i|pagename|runs| 06:38:38 INFO - PROCESS | 1682 | |0;ai-astar;112;112;112;111;111;113;129;111;111;111 06:38:38 INFO - PROCESS | 1682 | |1;audio-beat-detection;155;124;154;151;113;140;118;151;149;119 06:38:38 INFO - PROCESS | 1682 | |2;audio-dft;182;186;182;189;226;197;260;208;182;183 06:38:38 INFO - PROCESS | 1682 | |3;audio-fft;73;81;71;115;61;80;84;83;120;56 06:38:38 INFO - PROCESS | 1682 | |4;audio-oscillator;88;89;130;78;80;84;137;112;117;158 06:38:38 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;87;85;87;85;87;84;87;85;86;84 06:38:38 INFO - PROCESS | 1682 | |6;imaging-darkroom;93;92;92;93;93;101;95;93;93;92 06:38:38 INFO - PROCESS | 1682 | |7;imaging-desaturate;87;85;85;84;84;85;86;86;84;84 06:38:38 INFO - PROCESS | 1682 | |8;json-parse-financial;54;57;58;57;56;58;78;86;101;85 06:38:38 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;63;62;71;63;71;69;65;66;66;66 06:38:38 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;81;81;81;79;81;81;81;81;80;84 06:38:38 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;125;125;129;122;118;118;117;116;115;119 06:38:38 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;134;133;135;132;124;121;150;134;133;161 06:38:38 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;68;65;65;66;65;65;57;62;87;96 06:38:38 INFO - PROCESS | 1682 | __end_tp_report 06:38:38 INFO - PROCESS | 1682 | __start_cc_report 06:38:38 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1183 06:38:38 INFO - PROCESS | 1682 | __end_cc_report 06:38:38 INFO - PROCESS | 1682 | __startTimestamp1465220318136__endTimestamp 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | ------- Summary: start ------- 06:38:38 INFO - PROCESS | 1682 | Number of tests: 14 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:113.30 Median:112.00 stddev:5.56 (5.0%) stddev-sans-first:5.88 06:38:38 INFO - PROCESS | 1682 | Values: 112.0 112.0 112.0 111.0 111.0 113.0 129.0 111.0 111.0 111.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:150.00 stddev:16.95 (11.3%) stddev-sans-first:16.74 06:38:38 INFO - PROCESS | 1682 | Values: 155.0 124.0 154.0 151.0 113.0 140.0 118.0 151.0 149.0 119.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:199.50 Median:193.00 stddev:25.66 (13.3%) stddev-sans-first:26.42 06:38:38 INFO - PROCESS | 1682 | Values: 182.0 186.0 182.0 189.0 226.0 197.0 260.0 208.0 182.0 183.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:20.71 (27.1%) stddev-sans-first:21.69 06:38:38 INFO - PROCESS | 1682 | Values: 73.0 81.0 71.0 115.0 61.0 80.0 84.0 83.0 120.0 56.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:79.00 stddev:27.77 (35.1%) stddev-sans-first:28.56 06:38:38 INFO - PROCESS | 1682 | Values: 88.0 89.0 130.0 78.0 80.0 84.0 137.0 112.0 117.0 158.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.50 stddev:1.25 (1.4%) stddev-sans-first:1.24 06:38:38 INFO - PROCESS | 1682 | Values: 87.0 85.0 87.0 85.0 87.0 84.0 87.0 85.0 86.0 84.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:93.00 stddev:2.71 (2.9%) stddev-sans-first:2.86 06:38:38 INFO - PROCESS | 1682 | Values: 93.0 92.0 92.0 93.0 93.0 101.0 95.0 93.0 93.0 92.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.05 (1.2%) stddev-sans-first:0.83 06:38:38 INFO - PROCESS | 1682 | Values: 87.0 85.0 85.0 84.0 84.0 85.0 86.0 86.0 84.0 84.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:58.00 stddev:16.91 (29.2%) stddev-sans-first:17.04 06:38:38 INFO - PROCESS | 1682 | Values: 54.0 57.0 58.0 57.0 56.0 58.0 78.0 86.0 101.0 85.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:3.22 (4.9%) stddev-sans-first:3.21 06:38:38 INFO - PROCESS | 1682 | Values: 63.0 62.0 71.0 63.0 71.0 69.0 65.0 66.0 66.0 66.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:1.25 (1.5%) stddev-sans-first:1.32 06:38:38 INFO - PROCESS | 1682 | Values: 81.0 81.0 81.0 79.0 81.0 81.0 81.0 81.0 80.0 84.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:120.50 stddev:4.62 (3.8%) stddev-sans-first:4.59 06:38:38 INFO - PROCESS | 1682 | Values: 125.0 125.0 129.0 122.0 118.0 118.0 117.0 116.0 115.0 119.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.70 Median:134.00 stddev:11.70 (8.7%) stddev-sans-first:12.39 06:38:38 INFO - PROCESS | 1682 | Values: 134.0 133.0 135.0 132.0 124.0 121.0 150.0 134.0 133.0 161.0 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:65.50 stddev:12.09 (18.5%) stddev-sans-first:12.81 06:38:38 INFO - PROCESS | 1682 | Values: 68.0 65.0 65.0 66.0 65.0 65.0 57.0 62.0 87.0 96.0 06:38:38 INFO - PROCESS | 1682 | -------- Summary: end -------- 06:38:38 INFO - PROCESS | 1682 | 06:38:38 INFO - TEST-INFO | 1682: exit 0 06:38:38 INFO - TEST-OK | kraken | took 56496ms 06:38:38 INFO - SUITE-END | took 1168s 06:38:39 INFO - Completed test suite (00:19:28) 06:38:39 INFO - javascript benchmark 06:38:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3579.552555930509, 3655.3420384330843, 3663.67026967573, 3670.8164591770405, 3714.8699795507164, 5898.434181131205, 5908.645481271126, 5910.0, 5934.614250073742, 5939.316978547468, 5923.3484316725235, 5953.553483488734, 5953.791617293396, 5970.761169553212, 5979.372165922581, 5235.973820130894, 5327.520523152915, 5349.919751203735, 5379.757910894019, 5424.240606315119, 5406.783728650849, 5425.891482170354, 5434.049041417756, 5436.456354364552, 5437.809676661318, 5266.7629956652045, 5352.4915133062495, 5371.650842695212, 5389.649672771257, 5423.078076726946, 5394.541463975567, 5402.432744561824, 5430.619856610039, 5439.211314359435, 5490.835274941718, 5188.247704082924, 5361.463853614647, 5369.892602147936, 5380.973095134538, 5381.5425688816495, 5743.54051675865, 5793.073108302651, 5815.883682326372, 5826.679532625704, 5874.853128671817, 6261.780837670705, 6328.050792381134, 6336.049592561107, 6337.6197428154455, 6338.809835704937, 6252.624842509418, 6259.561830671855, 6261.123442718023, 6299.905501417483, 6330.208723909512, 6032.276126864805, 6069.393060693896, 6078.6048906820915, 6084.513238940918, 6092.147099406086, 6265.96867015662, 6338.492920566344, 6402.263739669905, 6424.453921416639, 6428.164338636041, 6322.747090116436, 6329.240491141092, 6339.746410143543, 6353.142325786052, 6360.77737279193, 6310.116583678288, 6320.399562041599, 6327.651979141099, 6340.0, 6343.207099112611, 6262.342454042351, 6280.340564240689, 6352.745890164341, 6355.269144048401, 6362.013887847298, 6213.937860621426, 6256.5307601930035, 6291.496680265568, 6318.0, 6318.020706790455, 5046.596272298208, 5073.365829271341, 5081.3140226069745, 5082.440931497532, 5090.669106508065, 4521.954780452219, 4554.88612784683, 4587.9082418351445, 4608.078384323148, 4616.8614941551805, 6009.879802403927, 6027.301887261676, 6028.457438830438, 6056.485198758155, 6071.635701857903, 6247.125402443661, 6282.183316168869, 6298.118263443122, 6314.55798094129, 6327.96836015817, 6032.185654936615, 6077.9392206078255, 6080.483158931452, 6080.969595151996, 6084.452399284086, 5538.44615538451, 5558.416366281563, 5559.138333558305, 5565.916511252334, 5578.470045345685, 6323.146375239376, 6341.143945567382, 6420.775272865428, 6423.96788016057, 6511.641859697667, 6273.874522509615, 6281.560290779602, 6282.2147231596055, 6288.434040936338, 6298.338674439118, 6475.061116138228, 6516.380943810331, 6520.673966301761, 6526.869462610816, 6535.967320163369, 6219.346968568235, 6246.968765156327, 6254.186955695731, 6321.52588555851, 6327.272363678236, 6264.59280146789, 6272.278687950944, 6289.7484100635465, 6297.716602752978, 6309.589876658002, 5340.706261155674, 6117.279373342293, 6278.529110316653, 6293.559450838397, 6294.0, 6162.198914141133, 6252.249730032425, 6260.499160067275, 6262.0, 6266.686665666607, 6116.082587611894, 6150.876982460415, 6175.876482470415, 6191.84520386994, 6192.659403732838, 6151.292601350902, 6200.844978875564, 6256.906146407899, 6297.622142671271, 6319.368063193644, 6141.486007784364, 6181.505479561534, 6185.6907154641185, 6185.84535386619, 6192.287886892885], "unit": "score", "name": "dojo.html", "value": 5868.055343680854}, {"lowerIsBetter": false, "replicates": [462.78711792575433, 542.6038991536176, 574.1674571870785, 676.6973575866457, 677.8508728079823, 29506.85246573767, 40185.79907100468, 40607.0, 40730.18539629206, 40800.79599602002, 43764.562354376445, 43998.7800061, 44147.558524414744, 44206.55793442065, 44318.77840610792, 9707.0, 9941.453220072894, 9942.65200717975, 9945.055219754147, 9961.651342203024, 9675.129238368545, 9768.609255629803, 9809.117179453848, 9821.410715357102, 9828.312018158731, 8619.827603447928, 9802.705918822447, 9821.70534883951, 9998.350107243043, 10010.249231307645, 8387.412881098326, 8867.822643547157, 9818.509074546315, 9902.603895844193, 9935.701928942144, 9675.032496750338, 9777.266704997153, 9783.46190959497, 9788.90211097887, 9805.558749856202, 43021.56978430207, 43347.78326108381, 43547.56452435467, 43551.56448435507, 43560.78219608913, 3292.6378098409155, 3343.481760327153, 3379.0031940577587, 3821.197548514815, 4025.174839157995, 29167.41665166706, 30208.395832083235, 30247.546286805715, 30253.394932101233, 30720.0, 2793.385455199853, 2818.689944106147, 2822.4919514487383, 2830.1226619747945, 2896.2614533294086, 505288.0, 506472.0, 506527.4673626645, 507987.0, 509162.0, 69699.0, 70217.94673079909, 70402.29597703957, 70485.64757176182, 70615.0, 75403.62298188474, 77649.0, 78631.60684196542, 78840.81738773923, 78936.81594776083, 18969.956652383975, 19223.711644325347, 19228.0, 19238.519037024187, 19264.32574859873, 14462.349194286282, 14566.271686415637, 14567.41730330775, 14579.41682332716, 14589.489367872286, 22375.88812055929, 22670.433239169153, 22678.886605566866, 22692.432689182573, 22736.43158921007, 9298.163165315154, 9528.714138575853, 9550.474723890115, 9567.234621230285, 9582.472963986907, 966.5602151021268, 1070.710908054821, 1087.3732269194527, 1104.9779004420027, 1112.2047735868894, 30632.84683576568, 30664.84667576648, 31046.22384440407, 31138.0, 31351.529727054112, 1144.5307423956137, 1180.698921774942, 1185.697647099984, 1218.4273391506156, 1257.0383656502784, 15384.461543845911, 15669.843301567067, 15843.683126337408, 15844.253682520062, 15942.28259728315, 563333.0, 568725.0, 570127.0, 572683.0, 572723.0, 62588.0, 63024.054639180446, 63180.052299215546, 63346.68326658337, 63372.36627633757, 1446.5298777897226, 1557.961050973712, 1562.211083402897, 1587.777711120444, 1595.8244593094983, 29059.12822615325, 29487.378194198667, 29600.703992959796, 29684.40631187321, 30086.0, 48294.03411931671, 48827.26759098545, 48846.0, 48904.75547622239, 48910.0, 324228.0, 325277.0, 325789.0, 326048.0, 326772.0, 30289.697103028688, 48317.03365932732, 48985.0, 49466.75266623644, 49923.001539968274, 47693.52306476891, 47830.760846195546, 47888.521114788404, 48352.758236208596, 49683.254751179484, 37365.0, 37963.62036379711, 38313.233735325695, 38455.423168653055, 39298.410523841594, 37469.43795843119, 37524.249515010095, 38128.428073579475, 38235.0, 39121.804390977864, 40127.39808902927, 40195.79902100471, 40753.0, 41375.58624413717, 41418.792906036484, 34644.48033279553, 35187.0, 35886.10284742902, 36055.27889442249, 36187.276254474236, 21763.891180543997, 26165.607515886895, 26612.60081098824, 26779.0, 27059.323516912234], "unit": "score", "name": "ext.html", "value": 20950.62418455657}, {"lowerIsBetter": false, "replicates": [386.81046287319214, 390.2760379496037, 392.45252872243213, 395.8812356293111, 400.4333867577378, 19971.900140499296, 21026.579468410622, 21159.894200529016, 21438.89280553595, 21465.892670536647, 21694.240701575447, 21766.673499897475, 22418.0, 22426.88786556069, 22604.54790904181, 5886.234789477362, 6005.279366476029, 6080.179175811253, 6098.420650038262, 6102.023676211807, 5860.208871802295, 6002.3697511761075, 6022.337542870281, 6039.335673075958, 6062.757489700407, 5804.622699524539, 6008.3390827009, 6013.579049466539, 6024.126501657257, 6046.848828779272, 5950.523958083343, 5969.970150149265, 6011.2786465624185, 6015.789447369343, 6018.8495287617725, 5652.208690783294, 5661.377248502661, 5688.886222275572, 5711.200431939532, 5725.513331366838, 13790.0, 14165.78751318731, 14276.500322488662, 14314.785278220836, 14354.856451435457, 1771.929122835085, 1880.1539307311764, 2044.366246463601, 2392.12687369109, 2809.987304274224, 8650.39967605995, 9813.558389872473, 9944.105030547285, 10200.540975656113, 10725.30285531438, 1720.7676963609877, 1732.3763445159732, 1737.37454516374, 1745.179765510221, 1772.3087995681694, 78150.21849781543, 109215.0, 111068.0, 115991.0, 117829.41085294605, 9936.453495057696, 10477.9476102619, 11591.594294199662, 11657.650270491898, 11751.294922304689, 14456.85543144555, 14464.493742719165, 14470.842332613365, 14488.34802433893, 14524.564263072125, 9023.729288121367, 9143.862842057375, 9155.725328240163, 9214.90785092154, 9239.122283383067, 9466.479343636029, 9468.431894086378, 9485.857712134324, 9494.810103797885, 9579.712608621752, 4466.330050492452, 4543.7728113594185, 4554.0, 4558.0, 4604.194266003436, 1627.4466681328406, 1915.8658893877296, 1921.788603253641, 1924.4034349351746, 1973.181129831104, 931.4504442379028, 960.4813400763649, 974.6247694637474, 1008.9899101008896, 1030.4950574218728, 20477.283295084602, 20599.4850128745, 20636.0, 20643.69034464484, 20880.0, 1036.3419228789621, 1039.2361614213546, 1067.9252452328417, 1071.6624263357019, 1084.3493903657743, 10974.122070234362, 11333.036691881283, 11379.886201138048, 11388.202825802115, 11397.145214108976, 650037.0, 657104.0, 688739.0, 689606.0, 695326.0, 82289.0, 113926.0, 120672.396638018, 141057.8841317381, 143166.0, 1061.7823346214007, 1089.9128069754402, 1090.5801266512292, 1093.2620481175175, 1094.8412480190486, 18265.634687306447, 18727.438176854717, 19022.7146592804, 19093.236270549023, 19380.93404862746, 32882.50676239906, 34939.65060349364, 54911.0, 55609.60975975633, 58989.0, 78522.42955140979, 79032.0, 80537.0, 80755.0, 82367.17632823595, 6901.378875901193, 7158.785236442915, 8157.1842815717955, 8160.0, 8215.548144852091, 11925.880741192477, 12836.358182091044, 13009.674758131123, 13229.140105893086, 13280.734385312433, 11022.50398732075, 11085.334879907232, 11301.321920684784, 11347.943260283646, 11514.021308188898, 9838.557264923238, 10565.947170264408, 10619.628313009007, 11243.381614011309, 11627.0, 9984.500774961369, 10245.74385640365, 10919.290246133976, 11517.021053210236, 11578.073754099483, 7875.527468351917, 7880.975473188449, 8091.433599647969, 8164.795880102807, 8180.754577362689, 9748.122668959828, 11227.719307017063, 11282.323060616389, 11336.6032188873, 11374.94312528432], "unit": "score", "name": "jquery.html", "value": 9507.735235472406}, {"lowerIsBetter": false, "replicates": [1496.5809573319461, 1634.1339090282152, 1656.320908427545, 1976.8912709800964, 2065.0707181768207, 8191.3856460765455, 8921.955390223047, 9074.274058075354, 9082.591283392247, 9108.81782364353, 8717.825643487127, 9013.233875120606, 9015.774605634862, 9020.684276050339, 9067.818643627124, 2152.9892350538303, 2553.770160685538, 2585.58630619101, 2589.2361753282826, 2592.8055395845295, 2480.131953816159, 2588.598767191079, 2589.4303253284247, 2590.5337039332912, 2601.6747906511687, 2546.9235922922344, 2566.9218928050173, 2577.8453292802396, 2585.418280886804, 2590.766830985211, 2125.787421257877, 2530.367408147963, 2539.898404063835, 2540.428403609173, 2580.380708629934, 2538.923832285034, 2542.300867261518, 2542.720300766914, 2545.0, 2596.9741951929072, 9072.410293330913, 9188.586513606904, 9192.310576706706, 9205.723828285161, 9207.585658645377, 5589.860253493654, 5775.162601422812, 5783.277090363705, 5785.479306862402, 5800.100984347433, 3613.114786877232, 3669.1377526281303, 3743.9812800936093, 3758.248350329945, 3784.791836448994, 1053.4837929414532, 1071.9464026798628, 1073.5652060915343, 1086.8369744538304, 1107.053469283759, 12225.327606981613, 12384.071194660346, 12388.752224955451, 12415.379231038412, 12434.440450179764, 4989.501049894981, 4990.800367985313, 5047.671901326402, 5049.82325618609, 5049.92952889321, 10414.583416663248, 10443.582256709646, 10457.477126143662, 10460.895391046144, 10491.632792852213, 5691.317041954909, 5701.059325211294, 5703.344115426779, 5742.28221472316, 5743.798967036134, 4686.95313046872, 4867.951320486821, 5008.649394542347, 5152.562032227228, 5214.2960700304975, 3964.4053391991433, 3998.9400158997637, 4039.8586049488713, 4065.4511640928686, 4078.8164532596106, 1341.6176389729076, 1354.228089988697, 1358.1647286918671, 1368.1244003837553, 1371.1978492581752, 1312.1471043821593, 1442.1923722715312, 1465.3186268385039, 1465.5383554180398, 1466.8533146685247, 8405.159484051546, 8473.406861519634, 8524.616392262238, 8541.359398045171, 8550.828983420297, 532.8268312798278, 543.5760107116455, 543.9347278326547, 554.9944500554943, 555.2698201864536, 6328.6835658216905, 6331.873362532723, 6355.936440635627, 6363.681815909186, 6378.744850206032, 10803.83794243087, 11192.944035279772, 11323.94338028321, 11325.603603873826, 11329.0, 8961.417507861968, 10632.149428045737, 11021.944890275498, 11066.059384952368, 11083.445827708743, 6978.720851165896, 8557.10150434208, 8594.0, 8672.0, 8681.956590217009, 8090.312323452573, 8099.797505062184, 8214.178582141738, 8277.917220827956, 8382.161783821814, 9594.856077158709, 9762.511874406393, 9887.604495820375, 9914.504274786375, 9930.801383972424, 9866.556004979937, 10136.94931525367, 10266.897331026892, 10336.586536538754, 10339.896601034194, 7577.507462014952, 7603.505772124794, 7622.16156222804, 7705.0, 7717.922820771945, 8501.234888860032, 8525.275351594935, 8572.78568035779, 8598.140185981352, 8606.44058136219, 7562.395008399205, 7721.150673425806, 7767.844643106993, 7779.37764978789, 7814.101378341564, 7511.248875112445, 7527.473076884566, 7595.734149304748, 7664.846703065796, 7684.0, 8087.353011759163, 8170.714025009096, 8180.263776260165, 8181.754547363588, 8185.631646576037, 7238.927610723826, 7387.667554959932, 7400.962995184989, 7416.629168541659, 7416.66625001887, 6169.753209871555, 7491.925080749123, 7503.437242206747, 7507.249275072449, 7514.661840217313], "unit": "score", "name": "mootools.html", "value": 5028.10679964077}, {"lowerIsBetter": false, "replicates": [333.9448990916499, 340.75125158634194, 344.03841263668045, 344.5658470327387, 349.46357341480814, 6477.384648458401, 6480.31956644552, 6514.511411644122, 6527.575707579004, 6538.150040494741, 6410.743570257196, 6439.356064393558, 6457.967710161454, 6464.028471316246, 6469.902951455732, 4643.698159619631, 4732.124556956974, 4770.4275486941615, 4886.413630364353, 4892.461829198803, 4848.7575621218975, 4880.194767863299, 4890.828820991266, 4895.9755201224125, 4903.4606193318705, 4821.108095002418, 4821.7830197641015, 4826.927596086061, 4831.492693267209, 4843.39457567804, 4592.632589392841, 4693.859184224461, 4791.041791641685, 4805.111054454902, 4821.831235906761, 4130.339145736698, 4135.462389889325, 4135.77253251071, 4143.647789937859, 4160.2303573838635, 6111.816645500598, 6124.173236613089, 6128.479079278267, 6147.293061297919, 6150.261968563801, 5585.2459917910965, 5597.44025597441, 5603.879224155145, 5606.878624275161, 5610.102383618642, 6786.321367863224, 6786.8303292417595, 6788.456923446112, 6794.3545363190415, 6802.2857599951785, 4571.1771881061395, 4709.387779588632, 4729.645276604234, 4733.219018861883, 4735.810567577293, 6969.546979446371, 7088.255733148048, 7272.16370117438, 7316.780496585057, 7326.890096648554, 4157.667386609064, 4821.252705830602, 4826.131296366688, 4827.324174615486, 4838.346823178897, 4884.609231261491, 4885.780139893643, 4889.242167464049, 4895.922896962663, 4911.901761964741, 4919.655624106278, 5500.917486237709, 5734.913976290359, 5736.713164341766, 5744.788256521186, 6636.734530618721, 6833.180018397824, 6858.862822743517, 6877.071595334566, 6961.164660240804, 1661.950141495757, 1680.5210515003166, 1680.7142785726455, 1690.9661806763795, 1693.4750227429536, 908.4821651658623, 1045.592219034577, 1075.3762817565948, 1102.151343465543, 1126.4255229832845, 5061.392632884077, 6248.31268560458, 6258.15514905491, 6377.139086223393, 6556.27880933097, 6112.8777424452155, 6497.902531462032, 6942.548734332252, 7204.13550373948, 7214.67533960973, 6499.382558657015, 6502.934970650327, 6504.089427480157, 6515.250746164157, 6521.967390163114, 3746.925061498755, 3793.829277682511, 3795.18403543234, 3797.981010094987, 3799.1072098056934, 7268.491205615662, 7496.287852653989, 7534.133574638987, 7543.321101100927, 7574.431917606202, 7330.560166390033, 7391.8152046199275, 7397.556146631219, 7402.629868506553, 7410.296021877913, 7500.812479687942, 7506.28690274423, 7511.211322811136, 7525.774226773206, 7542.698292068475, 6977.6264591439685, 7183.712651493882, 7189.856202876018, 7195.496315257882, 7196.604186769778, 6940.514164008673, 7047.894281585678, 7047.929520704727, 7061.046758687511, 7085.256048114874, 7462.813429664302, 7479.626018699152, 7492.587907665131, 7494.288042635941, 7510.009847390336, 4791.592714619296, 4798.136335459651, 4807.18277892766, 4807.375041244616, 4808.014357056725, 7112.893306600302, 7121.750738724119, 7127.928720712726, 7130.429565634633, 7130.5365151265005, 5764.625299355528, 6664.83337916556, 6714.3957043866285, 6905.620190889549, 6943.305669433218, 6838.879947216379, 6882.7591034313555, 6885.965570172117, 6891.173059232924, 6907.378335949788, 5406.729663516887, 6713.56361836479, 6724.058631791651, 6729.360710732472, 6738.561993470409, 5513.917291240555, 6890.724371025103, 6907.965460172667, 6917.550359226634, 6921.93078069233, 6544.411003009752, 6668.499862510428, 6752.8649427010205, 6766.4248538874745, 6766.86466270662], "unit": "score", "name": "prototype.html", "value": 5089.394615121633}, {"lowerIsBetter": false, "replicates": [659.8449364399365, 700.4361489001355, 775.1783109903506, 790.9129995700474, 801.4550105927968, 15416.999999999985, 15614.29735661895, 15642.0, 15647.921760391211, 15663.21683915804, 14407.711845763079, 14448.566543003726, 14465.0, 14467.710645787078, 14507.564773056825, 793.0364607002491, 816.9714060007901, 967.4630580028081, 995.4972738766912, 996.6063404955038, 965.1313817564178, 975.9316847820655, 976.4483067067084, 981.8085473332703, 981.9836469254324, 850.1625898489982, 1045.8483519889612, 1050.831866901296, 1051.2063392138925, 1052.2686732720763, 1026.255964425789, 1050.7163065972145, 1052.4001319247993, 1053.6312290698195, 1053.815582273103, 653.4739534674585, 781.3631890009624, 782.8943092682472, 783.7139444102918, 785.7721260834351, 12358.258504489759, 14901.776473352907, 15192.936494445394, 15371.154586497738, 15442.536723898302, 12878.80681789774, 12880.935595321964, 13131.474741010348, 13461.865381346159, 13478.865211347858, 9515.762105947337, 11407.030402415805, 11582.47878845454, 11850.88149118515, 11949.22330048544, 3639.508666330038, 3670.8164591770305, 3700.8704695335805, 3736.17804083104, 3929.292727309083, 79963.8005429919, 84227.15772842316, 85078.29843403159, 85308.29383412359, 85538.14461855363, 9826.164775993977, 10213.846792298122, 10281.94859025715, 10301.433421161908, 10468.947655261674, 23901.0, 24238.272851814472, 24246.87876560606, 24256.514869702507, 24323.027078917, 6643.435307998778, 7937.0, 7965.840683186304, 8120.6345714443, 8271.379646526535, 3726.9813650932115, 3960.8019599019935, 4108.705757686319, 4244.702870799015, 4305.246581848164, 3718.1076541629814, 3753.0242137044565, 3776.86780962665, 3814.0, 3814.904627384338, 596.5317225977586, 662.7216569041015, 675.8580698053464, 709.9467539934526, 715.770953294951, 551.5807985930721, 563.9125935480007, 590.630855715178, 593.1902952469848, 631.8388810853295, 8007.599620018976, 8426.578671066422, 8549.743507694779, 8669.26311263537, 8853.335999799912, 550.9669419834822, 589.5313225985352, 612.3203244398713, 636.4685487617799, 640.4748106552676, 3247.935041299208, 3860.3630400983525, 3962.5244970603712, 4001.2197621463533, 4007.1785284016705, 91843.62234566487, 92622.53688731513, 97709.25198228189, 97923.0, 98787.51818722725, 80885.59557202176, 81215.0, 85563.0, 87353.56323218471, 88038.11961880299, 73636.89544656835, 75040.87438688424, 76127.61936190283, 76518.81144724102, 77248.91869370312, 6685.264620891795, 7363.300486453778, 7382.151052628801, 7989.241022102891, 8246.216609422096, 53027.20459193038, 53185.46814531805, 53243.0, 53330.73334633302, 53762.04308762899, 66732.0, 70405.0, 73059.53880922246, 74362.0, 76775.61612191904, 10248.128909042516, 10578.100861426865, 10655.89344106549, 10660.84008739885, 11261.493232804707, 10778.191635627203, 10971.0, 11003.0, 11120.388378639253, 11350.148738844784, 10527.420991845522, 10842.457877106272, 10876.836847447454, 10907.509162087883, 11067.612633557786, 10374.896251037695, 10526.52630631608, 10583.253763128998, 10685.252032357661, 10750.408727520062, 10340.793184136124, 10464.372137671764, 10584.89415105839, 10656.786864262516, 10846.0, 8678.958127135606, 8800.207981281716, 8873.023967363455, 9033.187013168847, 9159.725208243763, 8992.86510702353, 9057.68298109563, 9103.772405689911, 9185.081491850762, 9246.0], "unit": "score", "name": "yui.html", "value": 7076.730449025822}], "name": "dromaeo_css", "value": 7720.010870078053}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 112.0, 111.0, 111.0, 113.0, 129.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 154.0, 151.0, 113.0, 140.0, 118.0, 151.0, 149.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 137.4}, {"lowerIsBetter": true, "replicates": [182.0, 186.0, 182.0, 189.0, 226.0, 197.0, 260.0, 208.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 199.5}, {"lowerIsBetter": true, "replicates": [73.0, 81.0, 71.0, 115.0, 61.0, 80.0, 84.0, 83.0, 120.0, 56.0], "unit": "score", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [88.0, 89.0, 130.0, 78.0, 80.0, 84.0, 137.0, 112.0, 117.0, 158.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 85.0, 87.0, 84.0, 87.0, 85.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.7}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 92.0, 93.0, 93.0, 101.0, 95.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.7}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 85.0, 84.0, 84.0, 85.0, 86.0, 86.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.0}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 58.0, 57.0, 56.0, 58.0, 78.0, 86.0, 101.0, 85.0], "unit": "score", "name": "json-parse-financial", "value": 69.0}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 71.0, 63.0, 71.0, 69.0, 65.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.2}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 79.0, 81.0, 81.0, 81.0, 81.0, 80.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.0}, {"lowerIsBetter": true, "replicates": [125.0, 125.0, 129.0, 122.0, 118.0, 118.0, 117.0, 116.0, 115.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [134.0, 133.0, 135.0, 132.0, 124.0, 121.0, 150.0, 134.0, 133.0, 161.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.7}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 65.0, 66.0, 65.0, 65.0, 57.0, 62.0, 87.0, 96.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1446.2}]} 06:38:39 INFO - Return code: 0 06:38:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:38:39 INFO - # TBPL SUCCESS # 06:38:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:38:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:38:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:38:39 INFO - 2016-06-06 06:38:39.417 screenresolution[1686:10412] starting screenresolution argv=screenresolution get 06:38:39 INFO - 2016-06-06 06:38:39.420 screenresolution[1686:10412] Display 0: 1600x1200x32@60 06:38:39 INFO - 2016-06-06 06:38:39.426 screenresolution[1687:10415] starting screenresolution argv=screenresolution list 06:38:39 INFO - Available Modes on Display 0 06:38:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:38:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:38:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:38:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:38:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:38:39 INFO - Intel Iris: 06:38:39 INFO - Chipset Model: Intel Iris 06:38:39 INFO - Type: GPU 06:38:39 INFO - Bus: Built-In 06:38:39 INFO - VRAM (Dynamic, Max): 1536 MB 06:38:39 INFO - Vendor: Intel (0x8086) 06:38:39 INFO - Device ID: 0x0a2e 06:38:39 INFO - Revision ID: 0x0009 06:38:39 INFO - Displays: 06:38:39 INFO - Display: 06:38:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:38:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:38:39 INFO - Display Serial Number: 1600x1200 60 06:38:39 INFO - Main Display: Yes 06:38:39 INFO - Mirror: Off 06:38:39 INFO - Online: Yes 06:38:39 INFO - Rotation: Supported 06:38:39 INFO - Return code: 0 06:38:39 INFO - Running post-action listener: _resource_record_post_action 06:38:39 INFO - Running post-run listener: _resource_record_post_run 06:38:40 INFO - Total resource usage - Wall time: 1192s; CPU: 52.0%; Read bytes: 32808448; Write bytes: 511118848; Read time: 328; Write time: 1717 06:38:40 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 200782336; Write bytes: 199861248; Read time: 17962; Write time: 437 06:38:40 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 31051264; Write bytes: 300460544; Read time: 304; Write time: 1247 06:38:40 INFO - Running post-run listener: _upload_blobber_files 06:38:40 INFO - Blob upload gear active. 06:38:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:38:40 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:38:40 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:38:40 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:38:41 INFO - (blobuploader) - INFO - Open directory for files ... 06:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:38:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:42 INFO - (blobuploader) - INFO - Done attempting. 06:38:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:38:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:38:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:43 INFO - (blobuploader) - INFO - Done attempting. 06:38:43 INFO - (blobuploader) - INFO - Iteration through files over. 06:38:43 INFO - Return code: 0 06:38:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:38:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:38:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/341434e486c27450c162c550bb1773f4fe140a6bd4b5f1e390634851d90966b6ce901c9410de4c1ec32e3e51144dddf7371f47d7e5fb22d57741e6da888b0245", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c0604463d74fc112c7a3176ee6df9c24bea2eccb16f208dff8e1ec0c9dbb1d12c2fa135e128f9a90e58c34951c98a288b2d998961fe8b1be27b7f3a40c3fef3"} 06:38:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:38:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:38:43 INFO - Contents: 06:38:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/341434e486c27450c162c550bb1773f4fe140a6bd4b5f1e390634851d90966b6ce901c9410de4c1ec32e3e51144dddf7371f47d7e5fb22d57741e6da888b0245", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c0604463d74fc112c7a3176ee6df9c24bea2eccb16f208dff8e1ec0c9dbb1d12c2fa135e128f9a90e58c34951c98a288b2d998961fe8b1be27b7f3a40c3fef3"} 06:38:43 INFO - Running post-run listener: copy_logs_to_upload_dir 06:38:43 INFO - Copying logs to upload dir... 06:38:43 INFO - mkdir: /builds/slave/test/build/upload/logs 06:38:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.154807 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-06 06:38:43.441240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:38:43.444614) ========= 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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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/341434e486c27450c162c550bb1773f4fe140a6bd4b5f1e390634851d90966b6ce901c9410de4c1ec32e3e51144dddf7371f47d7e5fb22d57741e6da888b0245", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c0604463d74fc112c7a3176ee6df9c24bea2eccb16f208dff8e1ec0c9dbb1d12c2fa135e128f9a90e58c34951c98a288b2d998961fe8b1be27b7f3a40c3fef3"} build_url:https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010984 build_url: 'https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/341434e486c27450c162c550bb1773f4fe140a6bd4b5f1e390634851d90966b6ce901c9410de4c1ec32e3e51144dddf7371f47d7e5fb22d57741e6da888b0245", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c0604463d74fc112c7a3176ee6df9c24bea2eccb16f208dff8e1ec0c9dbb1d12c2fa135e128f9a90e58c34951c98a288b2d998961fe8b1be27b7f3a40c3fef3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:38:43.480078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:38:43.480793) ========= 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.W80Om5xNdd/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.7SmhZkZ1Td/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.005035 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:38:43.534356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:38:43.535025) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:38:43.535798) ========= ========= Total master_lag: 1.72 =========