Back to build
Raw log | Switch to full mode | Login

python -u /b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py --verbose -o /b/s/w/ir/tmp/t/tmpFA7eBD.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/16y021QI --merge-script /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py --merge-script-stdout-file /b/s/w/ir/tmp/t/tmpv65Ajtmerge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpq9Zxvz.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpt9g7a0.json in dir /b/s/w/ir/k: allow_subannotations: False cmd: ['python', '-u', '/b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py', '--verbose', '-o', '/b/s/w/ir/tmp/t/tmpFA7eBD.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/16y021QI', '--merge-script', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--merge-script-stdout-file', '/b/s/w/ir/tmp/t/tmpv65Ajtmerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpq9Zxvz.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/s/w/ir/tmp/t/tmpt9g7a0.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('ios_chrome_web_egtests (iPad Air 2 iOS 11.4) on Mac-10.13.6',) ok_ret: ALL_OK step_test_data: gen_default_step_test_data(...) trigger_specs: () full environment: Apple_PubSub_Socket_Render: /private/tmp/com.apple.launchd.Gtelh2K1RE/Render BOTO_CONFIG: /b/s/w/ir/tmp/gsutil_task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CIPD_CACHE_DIR: /b/s/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 56100 DOCKER_CONFIG: /b/s/w/ir/tmp/docker_cfg_task DOCKER_TMPDIR: /b/s/w/ir/tmp/docker_tmp_task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /Users/chrome-bot INFRA_GIT_WRAPPER_HOME: /b/s/w/ir/tmp/git_home_task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8915664965927445088 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/itNREIWb/luci_context.408780021 MAC_CHROMIUM_TMPDIR: /b/s/w/ir/tmp/t NO_GCE_CHECK: False PATH: /b/s/w/ir/cache/swarming_client:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/opt/local/bin:/opt/local/sbin:/usr/local/sbin:/usr/local/git/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin PWD: /b/s/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SHELL: /bin/bash SHLVL: 1 SSH_AUTH_SOCK: /private/tmp/com.apple.launchd.4tYAusIoFz/Listeners SWARMING_BOT_ID: vm124-m9 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 44531f3c9291e611 TEMP: /b/s/w/ir/tmp/t TEMPDIR: /b/s/w/ir/tmp/t TMP: /b/s/w/ir/tmp/t TMPDIR: /b/s/w/ir/tmp/t USER: chrome-bot VERSIONER_PYTHON_PREFER_32_BIT: no VERSIONER_PYTHON_VERSION: 2.7 VPYTHON_VIRTUALENV_ROOT: /b/s/w/ir/cache/vpython XPC_FLAGS: 0x0 XPC_SERVICE_NAME: 0 _: /b/s/w/ir/cipd_bin_packages/vpython __CF_USER_TEXT_ENCODING: 0x1F4:0x0:0x0 Set PYTHONPATH: /b/s/w/ir/kitchen-checkout/build/scripts:/b/s/w/ir/kitchen-checkout/build/site_config:/b/s/w/ir/kitchen-checkout/build/third_party:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/s/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/s/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/s/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/s/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/s/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/s/w/ir/kitchen-checkout/build/third_party/jinja2:/b/s/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/s/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/s/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/s/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/s/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/s/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/s/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/s/w/ir/kitchen-checkout/build/third_party/site-packages 2019-04-20 04:00:54,582 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/k/recipe_cleanup/16y021QI' 2019-04-20 04:00:54,582 - root: [WARNING] task_output_dir '/b/s/w/ir/k/recipe_cleanup/16y021QI' already exists! 2019-04-20 04:00:54,582 - root: [WARNING] task_output_dir existing content: [] 2019-04-20 04:00:54,582 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpt9g7a0.json -output-dir /b/s/w/ir/k/recipe_cleanup/16y021QI -task-summary-json /b/s/w/ir/tmp/t/tmpq9Zxvz.json [D2019-04-20T04:00:54.609912-07:00 1114 0 auth.go:1265] Minting a new token {"key":"luci_ctx/9cc05a276eb1f2729a4f8585b97747b2dd552d5be8944a5eb40ee80c7136fa2b", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-20T04:00:54.610030-07:00 1114 0 luci_ctx.go:138] POST http://127.0.0.1:56088/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/9cc05a276eb1f2729a4f8585b97747b2dd552d5be8944a5eb40ee80c7136fa2b", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-20T04:00:54.611904-07:00 1114 0 auth.go:1222] Token expires in 15m29.388114s {"key":"luci_ctx/9cc05a276eb1f2729a4f8585b97747b2dd552d5be8944a5eb40ee80c7136fa2b", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 445329fc5914dd10: exit 0 [I 2019-04-20 03:44:11] About to install Xcode 10b61 in Xcode.app for ios [03:44:13:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer Device wiped. [03:44:21:DEBUG] Setting sigterm handler. [03:44:23:INFO] User defaults from command line: [03:44:23:INFO] IDETestRunSpecificationPath = /var/folders/2j/22s2gz0s7hn48k32d47clxf80000gm/T/D6260DFC-2DDA-4FD9-96D3-DF7E96DD8ADA [03:44:23:INFO] [03:44:23:INFO] Testing started on 'iPad Air 2' [03:44:23:INFO] 2019-04-20 03:44:23.523 xcodebuild[37467:503181] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [03:44:23:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-hjgbckvkeuxuddbjpnkehtviswbt/Logs/Test/Test-Transient Testing-2019.04.20_03-44-23--0700.xcresult/1_Test/Diagnostics/ios_chrome_web_egtests_module-797BB4AD-8C63-4315-B97B-164E696CDC34/ios_chrome_web_egtests_module-26B55F0F-7F13-4800-B20F-59F19F7A84EC/Session-ios_chrome_web_egtests_module-2019-04-20_034423-Jmf70W.log [03:44:23:INFO] 2019-04-20 03:44:23.524 xcodebuild[37467:503165] [MT] IDETestOperationsObserverDebug: (EC454118-B8E1-45AF-A61A-D913E740197B) Beginning test session ios_chrome_web_egtests_module-EC454118-B8E1-45AF-A61A-D913E740197B at 2019-04-20 03:44:23.524 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7faa0c051bc0> { [03:44:23:INFO] SimDevice: iPad Air 2 (F73BD8AA-059D-4D6F-82E0-74009F7C4F41, iOS 11.4, Shutdown) [03:44:23:INFO] } (11.4 (15F79)) [03:44:45:INFO] 2019-04-20 03:44:45.201 ios_chrome_web_egtests[37589:504575] Crash handler setup started. [03:44:45:INFO] 2019-04-20 03:44:45.201 ios_chrome_web_egtests[37589:504575] Crash handler setup completed. [03:44:45:INFO] 2019-04-20 03:44:45.202 ios_chrome_web_egtests[37589:504575] Enabling accessibility for automation on Simulator. [03:44:45:INFO] objc[37589]: Class VCWeakObjectHolder is implemented in both /b/s/w/ir/Xcode.app/Contents/Developer/Platforms/iPhoneOS.platform/Developer/Library/CoreSimulator/Profiles/Runtimes/iOS 11.4.simruntime/Contents/Resources/RuntimeRoot/System/Library/PrivateFrameworks/AVConference.framework/Frameworks/ViceroyTrace.framework/ViceroyTrace (0x14bbcb4d0) and /b/s/w/ir/Xcode.app/Contents/Developer/Platforms/iPhoneOS.platform/Developer/Library/CoreSimulator/Profiles/Runtimes/iOS 11.4.simruntime/Contents/Resources/RuntimeRoot/System/Library/PrivateFrameworks/AVConference.framework/AVConference (0x14b9e1e38). One of the two will be used. Which one is undefined. [03:44:49:INFO] 2019-04-20 03:44:49.055 ios_chrome_web_egtests[37589:504575] Unbalanced calls to begin/end appearance transitions for <TabGridViewController: 0x7fb73d065e00>. [03:44:49:INFO] [0420/034449.890440:ERROR:send_tab_to_self_client_service_ios.mm(97)] Not implemented reached in virtual void send_tab_to_self::SendTabToSelfClientServiceIOS::EntriesRemovedRemotely(const std::vector<std::string> &) [03:44:50:INFO] [0420/034450.868499:WARNING:leveldb_database.cc(106)] Unable to open /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/F73BD8AA-059D-4D6F-82E0-74009F7C4F41/data/Containers/Data/Application/9936A1C6-18AF-4EFB-BDD8-616D09BBC7FB/Library/Application Support/Chromium/Default/shared_proto_db: Invalid argument: /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/F73BD8AA-059D-4D6F-82E0-74009F7C4F41/data/Containers/Data/Application/9936A1C6-18AF-4EFB-BDD8-616D09BBC7FB/Library/Application Support/Chromium/Default/shared_proto_db: does not exist (create_if_missing is false) [03:44:56:INFO] Test Suite 'All tests' started at 2019-04-20 03:44:56.612 [03:44:56:INFO] Test Suite 'ios_chrome_web_egtests.app' started at 2019-04-20 03:44:56.613 [03:44:56:INFO] Test Suite 'BrowsingPreventDefaultTestCase' started at 2019-04-20 03:44:56.613 [03:44:56:INFO] [0420/034456.622312:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:44:58:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesStopPropagation]' started. [03:45:00:INFO] [0420/034500.578720:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:45:03:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesStopPropagation]' passed (4.971 seconds). [03:45:03:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesTargetBlank]' started. [03:45:08:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesTargetBlank]' passed (4.873 seconds). [03:45:08:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesWindowOpen]' started. [03:45:14:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesWindowOpen]' passed (5.947 seconds). [03:45:14:INFO] Test Suite 'BrowsingPreventDefaultTestCase' passed at 2019-04-20 03:45:14.271. [03:45:14:INFO] Executed 3 tests, with 0 failures (0 unexpected) in 15.791 (17.658) seconds [03:45:14:INFO] Test Suite 'BrowsingTestCase' started at 2019-04-20 03:45:14.272 [03:45:14:INFO] [0420/034514.273114:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:45:14:INFO] Test Case '-[BrowsingTestCase testBrowsingJavaScriptBasedNavigation]' started. [03:45:16:INFO] [0420/034516.253209:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:45:21:INFO] Test Case '-[BrowsingTestCase testBrowsingJavaScriptBasedNavigation]' passed (7.378 seconds). [03:45:21:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagation]' started. [03:45:27:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagation]' passed (5.957 seconds). [03:45:27:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagationRelativePath]' started. [03:45:33:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagationRelativePath]' passed (6.013 seconds). [03:45:33:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromScript]' started. [03:45:38:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromScript]' passed (4.992 seconds). [03:45:38:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromURL]' started. [03:45:43:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromURL]' passed (4.950 seconds). [03:45:43:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptNavigation]' started. [03:45:47:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptNavigation]' passed (3.635 seconds). [03:45:47:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptWithoutNavigation]' started. [03:45:50:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptWithoutNavigation]' passed (3.632 seconds). [03:45:50:INFO] Test Case '-[BrowsingTestCase testBrowsingWindowDataLinkScriptRedirect]' started. [03:45:56:INFO] Test Case '-[BrowsingTestCase testBrowsingWindowDataLinkScriptRedirect]' passed (6.042 seconds). [03:45:56:INFO] Test Case '-[BrowsingTestCase testPDFLoadTitle]' started. [03:46:02:INFO] Test Case '-[BrowsingTestCase testPDFLoadTitle]' passed (5.424 seconds). [03:46:02:INFO] Test Case '-[BrowsingTestCase testReload]' started. [03:46:08:INFO] Test Case '-[BrowsingTestCase testReload]' passed (6.187 seconds). [03:46:08:INFO] Test Case '-[BrowsingTestCase testTapLinkWithWebUIURL]' started. [03:46:13:INFO] Test Case '-[BrowsingTestCase testTapLinkWithWebUIURL]' passed (5.007 seconds). [03:46:13:INFO] Test Suite 'BrowsingTestCase' passed at 2019-04-20 03:46:13.499. [03:46:13:INFO] Executed 11 tests, with 0 failures (0 unexpected) in 59.216 (59.227) seconds [03:46:13:INFO] Test Suite 'CacheTestCase' started at 2019-04-20 03:46:13.500 [03:46:13:INFO] [0420/034613.501087:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:46:13:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnNavigateBackAndPageReload]' started. [03:46:15:INFO] 2019-04-20 03:46:15.379 ios_chrome_web_egtests[37589:504575] -- Earl Grey Test Disabled -- Disabled on iOS 10.3.1 and afterwards. [03:46:17:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnNavigateBackAndPageReload]' passed (3.746 seconds). [03:46:17:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnOpenNewTab]' started. [03:46:19:INFO] [0420/034619.280764:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:46:24:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnOpenNewTab]' passed (7.137 seconds). [03:46:24:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnSelectOmniboxSuggestion]' started. [03:46:26:INFO] 2019-04-20 03:46:26.211 ios_chrome_web_egtests[37589:504575] -- Earl Grey Test Disabled -- Test disabled on iPad. [03:46:28:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnSelectOmniboxSuggestion]' passed (3.692 seconds). [03:46:28:INFO] Test Suite 'CacheTestCase' passed at 2019-04-20 03:46:28.080. [03:46:28:INFO] Executed 3 tests, with 0 failures (0 unexpected) in 14.575 (14.581) seconds [03:46:28:INFO] Test Suite 'ChildWindowOpenByDOMTestCase' started at 2019-04-20 03:46:28.081 [03:46:28:INFO] [0420/034628.082403:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:46:28:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithName]' started. [03:46:30:INFO] [0420/034630.170128:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:46:34:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithName]' passed (6.820 seconds). [03:46:34:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithoutName]' started. [03:46:42:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithoutName]' passed (7.985 seconds). [03:46:42:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testChildWindowsWithAndWithoutName]' started. [03:46:50:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testChildWindowsWithAndWithoutName]' passed (7.941 seconds). [03:46:50:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithName]' started. [03:46:58:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithName]' passed (7.324 seconds). [03:46:58:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithoutName]' started. [03:47:07:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithoutName]' passed (8.986 seconds). [03:47:07:INFO] Test Suite 'ChildWindowOpenByDOMTestCase' passed at 2019-04-20 03:47:07.146. [03:47:07:INFO] Executed 5 tests, with 0 failures (0 unexpected) in 39.055 (39.065) seconds [03:47:07:INFO] Test Suite 'ErrorPageTestCase' started at 2019-04-20 03:47:07.147 [03:47:07:INFO] [0420/034707.148072:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:47:07:INFO] Test Case '-[ErrorPageTestCase testReloadErrorPage]' started. [03:47:09:INFO] [0420/034709.204296:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:47:13:INFO] Test Case '-[ErrorPageTestCase testReloadErrorPage]' passed (6.139 seconds). [03:47:13:INFO] Test Case '-[ErrorPageTestCase testReloadPageAfterServerIsDown]' started. [03:47:15:INFO] [0420/034715.385682:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:47:19:INFO] Test Case '-[ErrorPageTestCase testReloadPageAfterServerIsDown]' passed (6.124 seconds). [03:47:19:INFO] Test Suite 'ErrorPageTestCase' passed at 2019-04-20 03:47:19.416. [03:47:19:INFO] Executed 2 tests, with 0 failures (0 unexpected) in 12.263 (12.270) seconds [03:47:19:INFO] Test Suite 'FormsTestCase' started at 2019-04-20 03:47:19.417 [03:47:19:INFO] [0420/034719.418429:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:47:19:INFO] Test Case '-[FormsTestCase testGoBackButtonAfterFormSubmission]' started. [03:47:21:INFO] [0420/034721.497522:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:47:26:INFO] Test Case '-[FormsTestCase testGoBackButtonAfterFormSubmission]' passed (7.094 seconds). [03:47:26:INFO] Test Case '-[FormsTestCase testPostFormEntryWithKeyboard]' started. [03:47:30:INFO] 2019-04-20 03:47:30.680 ios_chrome_web_egtests[37589:504575] API error: <_UIKBCompatInputView: 0x7fb73ed6bd60; frame = (0 0; 0 0); layer = <CALayer: 0x60400102c200>> returned 0 width, assuming UIViewNoIntrinsicMetric [03:47:30:INFO] 2019-04-20 03:47:30.680 ios_chrome_web_egtests[37589:504575] API error: <_UIKBCompatInputView: 0x7fb73ed6bd60; frame = (0 0; 0 0); layer = <CALayer: 0x60400102c200>> returned 0 width, assuming UIViewNoIntrinsicMetric [03:47:36:INFO] Test Case '-[FormsTestCase testPostFormEntryWithKeyboard]' passed (9.849 seconds). [03:47:36:INFO] Test Case '-[FormsTestCase testPostFormToSamePage]' started. [03:47:45:INFO] Test Case '-[FormsTestCase testPostFormToSamePage]' passed (9.291 seconds). [03:47:45:INFO] Test Case '-[FormsTestCase testRepostFormAfterIndexNavigation]' started. [03:47:58:INFO] Test Case '-[FormsTestCase testRepostFormAfterIndexNavigation]' passed (12.424 seconds). [03:47:58:INFO] Test Case '-[FormsTestCase testRepostFormAfterReload]' started. [03:48:06:INFO] Test Case '-[FormsTestCase testRepostFormAfterReload]' passed (8.788 seconds). [03:48:06:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBack]' started. [03:48:16:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBack]' passed (9.923 seconds). [03:48:16:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBackAndForward]' started. [03:48:26:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBackAndForward]' passed (9.860 seconds). [03:48:26:INFO] Test Case '-[FormsTestCase testRepostFormCancelling]' started. [03:48:35:INFO] Test Case '-[FormsTestCase testRepostFormCancelling]' passed (8.620 seconds). [03:48:35:INFO] Test Case '-[FormsTestCase testRepostFormCancellingAfterRedirect]' started. [03:48:42:INFO] Test Case '-[FormsTestCase testRepostFormCancellingAfterRedirect]' passed (7.158 seconds). [03:48:42:INFO] Test Case '-[FormsTestCase testRepostFormDismissedByNewNavigation]' started. [03:48:50:INFO] Test Case '-[FormsTestCase testRepostFormDismissedByNewNavigation]' passed (7.715 seconds). [03:48:50:INFO] Test Suite 'FormsTestCase' passed at 2019-04-20 03:48:50.149. [03:48:50:INFO] Executed 10 tests, with 0 failures (0 unexpected) in 90.722 (90.732) seconds [03:48:50:INFO] Test Suite 'HTTPAuthTestCase' started at 2019-04-20 03:48:50.150 [03:48:50:INFO] [0420/034850.151130:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:48:50:INFO] Test Case '-[HTTPAuthTestCase testCancellingBasicAuth]' started. [03:48:52:INFO] 2019-04-20 03:48:52.062 ios_chrome_web_egtests[37589:504575] -- Earl Grey Test Disabled -- Tab Title not displayed on handset. [03:48:53:INFO] Test Case '-[HTTPAuthTestCase testCancellingBasicAuth]' passed (3.782 seconds). [03:48:53:INFO] Test Case '-[HTTPAuthTestCase testSuccessfullBasicAuth]' started. [03:48:55:INFO] 2019-04-20 03:48:55.828 ios_chrome_web_egtests[37589:504575] -- Earl Grey Test Disabled -- Tab Title not displayed on handset. [03:48:57:INFO] Test Case '-[HTTPAuthTestCase testSuccessfullBasicAuth]' passed (3.766 seconds). [03:48:57:INFO] Test Case '-[HTTPAuthTestCase testUnsuccessfullBasicAuth]' started. [03:48:59:INFO] 2019-04-20 03:48:59.598 ios_chrome_web_egtests[37589:504575] -- Earl Grey Test Disabled -- Tab Title not displayed on handset. [03:49:01:INFO] Test Case '-[HTTPAuthTestCase testUnsuccessfullBasicAuth]' passed (3.772 seconds). [03:49:01:INFO] Test Suite 'HTTPAuthTestCase' passed at 2019-04-20 03:49:01.475. [03:49:01:INFO] Executed 3 tests, with 0 failures (0 unexpected) in 11.320 (11.325) seconds [03:49:01:INFO] Test Suite 'JSPrintTestCase' started at 2019-04-20 03:49:01.475 [03:49:01:INFO] [0420/034901.476810:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:49:01:INFO] Test Case '-[JSPrintTestCase testWebPrintButton]' started. [03:49:03:INFO] [0420/034903.601216:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:49:07:INFO] 2019-04-20 03:49:07.504 ios_chrome_web_egtests[37589:504575] Warning: Attempt to dismiss from view controller <UIViewController: 0x7fb740e0e150> while a presentation or dismiss is in progress! [03:49:10:INFO] Test Case '-[JSPrintTestCase testWebPrintButton]' passed (8.702 seconds). [03:49:10:INFO] Test Suite 'JSPrintTestCase' passed at 2019-04-20 03:49:10.184. [03:49:10:INFO] Executed 1 test, with 0 failures (0 unexpected) in 8.702 (8.708) seconds [03:49:10:INFO] Test Suite 'NavigationTestCase' started at 2019-04-20 03:49:10.185 [03:49:10:INFO] [0420/034910.186298:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:49:10:INFO] Test Case '-[NavigationTestCase test301Redirect]' started. [03:49:12:INFO] [0420/034912.290292:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:49:21:INFO] Test Case '-[NavigationTestCase test301Redirect]' passed (10.873 seconds). [03:49:21:INFO] Test Case '-[NavigationTestCase testHistoryBackAndForwardAroundNTP]' started. [03:49:23:INFO] [0420/034923.187333:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:49:25:INFO] [0420/034925.897456:WARNING:web_state_impl.mm(661)] Script execution has failed: A JavaScript exception occurred [03:49:26:INFO] [0420/034926.350910:WARNING:web_state_impl.mm(661)] Script execution has failed: A JavaScript exception occurred [03:49:29:INFO] Test Case '-[NavigationTestCase testHistoryBackAndForwardAroundNTP]' passed (8.223 seconds). [03:49:29:INFO] Test Case '-[NavigationTestCase testHistoryBackNavigation]' started. [03:49:31:INFO] [0420/034931.440833:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:49:37:INFO] Test Case '-[NavigationTestCase testHistoryBackNavigation]' passed (8.410 seconds). [03:49:37:INFO] Test Case '-[NavigationTestCase testHistoryCrossDocumentLoad]' started. [03:49:39:INFO] [0420/034939.868139:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:49:45:INFO] Test Case '-[NavigationTestCase testHistoryCrossDocumentLoad]' passed (8.286 seconds). [03:49:45:INFO] Test Case '-[NavigationTestCase testHistoryForwardNavigation]' started. [03:49:48:INFO] [0420/034948.118925:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:49:54:INFO] Test Case '-[NavigationTestCase testHistoryForwardNavigation]' passed (8.454 seconds). [03:49:54:INFO] Test Case '-[NavigationTestCase testHistoryGoDelta]' started. [03:49:56:INFO] [0420/034956.593237:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:50:04:INFO] Test Case '-[NavigationTestCase testHistoryGoDelta]' passed (10.452 seconds). [03:50:04:INFO] Test Case '-[NavigationTestCase testHistoryGoDeltaZero]' started. [03:50:07:INFO] [0420/035007.043830:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:50:11:INFO] Test Case '-[NavigationTestCase testHistoryGoDeltaZero]' passed (6.121 seconds). [03:50:11:INFO] Test Case '-[NavigationTestCase testHistoryGoNoParameter]' started. [03:50:13:INFO] [0420/035013.136477:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:50:17:INFO] Test Case '-[NavigationTestCase testHistoryGoNoParameter]' passed (6.090 seconds). [03:50:17:INFO] Test Case '-[NavigationTestCase testHistoryGoOutOfBounds]' started. [03:50:19:INFO] [0420/035019.216932:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:50:24:INFO] Test Case '-[NavigationTestCase testHistoryGoOutOfBounds]' passed (7.023 seconds). [03:50:24:INFO] Test Case '-[NavigationTestCase testJavaScriptRedirect]' started. [03:50:26:INFO] [0420/035026.211996:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:50:32:INFO] Test Case '-[NavigationTestCase testJavaScriptRedirect]' passed (8.595 seconds). [03:50:32:INFO] Test Case '-[NavigationTestCase testRedirectRefresh]' started. [03:50:34:INFO] [0420/035034.821037:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:50:43:INFO] Test Case '-[NavigationTestCase testRedirectRefresh]' passed (10.928 seconds). [03:50:43:INFO] Test Case '-[NavigationTestCase testRedirectWindow]' started. [03:50:45:INFO] [0420/035045.803603:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:50:54:INFO] Test Case '-[NavigationTestCase testRedirectWindow]' passed (10.964 seconds). [03:50:54:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToNTPAndNavigateForward]' started. [03:50:56:INFO] [0420/035056.707726:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:51:02:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToNTPAndNavigateForward]' passed (8.161 seconds). [03:51:02:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToWebUIAndNavigateForward]' started. [03:51:06:INFO] [0420/035106.056975:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:51:13:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToWebUIAndNavigateForward]' passed (10.847 seconds). [03:51:13:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeHash]' started. [03:51:15:INFO] [0420/035115.782136:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:51:23:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeHash]' passed (9.581 seconds). [03:51:23:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeToSameHash]' started. [03:51:25:INFO] [0420/035125.327224:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:51:31:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeToSameHash]' passed (8.516 seconds). [03:51:31:INFO] Test Case '-[NavigationTestCase testWindowLocationReplaceAndChangeHash]' started. [03:51:33:INFO] [0420/035133.878983:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:51:40:INFO] Test Case '-[NavigationTestCase testWindowLocationReplaceAndChangeHash]' passed (8.313 seconds). [03:51:40:INFO] Test Suite 'NavigationTestCase' passed at 2019-04-20 03:51:40.036. [03:51:40:INFO] Executed 17 tests, with 0 failures (0 unexpected) in 149.835 (149.851) seconds [03:51:40:INFO] Test Suite 'ProgressIndicatorTestCase' started at 2019-04-20 03:51:40.037 [03:51:40:INFO] [0420/035140.037918:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:51:40:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterFormSubmit]' started. [03:51:41:INFO] 2019-04-20 03:51:41.898 ios_chrome_web_egtests[37589:504575] -- Earl Grey Test Skipped -- Skipped for iPad (no progress view in tablet) [03:51:43:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterFormSubmit]' passed (3.736 seconds). [03:51:43:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterSuppressedFormPost]' started. [03:51:45:INFO] 2019-04-20 03:51:45.683 ios_chrome_web_egtests[37589:504575] -- Earl Grey Test Skipped -- Skipped for iPad (no progress view in tablet) [03:51:47:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterSuppressedFormPost]' passed (3.786 seconds). [03:51:47:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShown]' started. [03:51:49:INFO] 2019-04-20 03:51:49.422 ios_chrome_web_egtests[37589:504575] -- Earl Grey Test Skipped -- Skipped for iPad (no progress view in tablet) [03:51:51:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShown]' passed (3.739 seconds). [03:51:51:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShownOnFormSubmit]' started. [03:51:53:INFO] 2019-04-20 03:51:53.138 ios_chrome_web_egtests[37589:504575] -- Earl Grey Test Skipped -- Skipped for iPad (no progress view in tablet) [03:51:55:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShownOnFormSubmit]' passed (3.713 seconds). [03:51:55:INFO] Test Suite 'ProgressIndicatorTestCase' passed at 2019-04-20 03:51:55.016. [03:51:55:INFO] Executed 4 tests, with 0 failures (0 unexpected) in 14.973 (14.979) seconds [03:51:55:INFO] Test Suite 'PushAndReplaceStateNavigationTestCase' started at 2019-04-20 03:51:55.016 [03:51:55:INFO] [0420/035155.017804:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:51:55:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryNavigatingPastNonPushedURL]' started. [03:51:57:INFO] [0420/035157.171855:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:52:09:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryNavigatingPastNonPushedURL]' passed (14.697 seconds). [03:52:09:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushStateThenGoBackAndForward]' started. [03:52:19:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushStateThenGoBackAndForward]' passed (10.021 seconds). [03:52:19:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushUnicodeCharacters]' started. [03:52:27:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushUnicodeCharacters]' passed (7.861 seconds). [03:52:27:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryReplaceStateThenGoBackAndForward]' started. [03:52:40:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryReplaceStateThenGoBackAndForward]' passed (12.795 seconds). [03:52:40:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryWithBase]' started. [03:52:45:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryWithBase]' passed (5.232 seconds). [03:52:45:INFO] Test Suite 'PushAndReplaceStateNavigationTestCase' passed at 2019-04-20 03:52:45.632. [03:52:45:INFO] Executed 5 tests, with 0 failures (0 unexpected) in 50.606 (50.616) seconds [03:52:45:INFO] Test Suite 'StopLoadingTestCase' started at 2019-04-20 03:52:45.633 [03:52:45:INFO] [0420/035245.633971:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:52:45:INFO] Test Case '-[StopLoadingTestCase testStopLoading]' started. [03:52:51:INFO] Test Case '-[StopLoadingTestCase testStopLoading]' passed (5.766 seconds). [03:52:51:INFO] Test Suite 'StopLoadingTestCase' passed at 2019-04-20 03:52:51.403. [03:52:51:INFO] Executed 1 test, with 0 failures (0 unexpected) in 5.766 (5.770) seconds [03:52:51:INFO] Test Suite 'TabOrderTestCase' started at 2019-04-20 03:52:51.404 [03:52:51:INFO] [0420/035251.404975:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:52:51:INFO] Test Case '-[TabOrderTestCase testChildTabOrdering]' started. [03:52:53:INFO] [0420/035253.494593:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:53:14:INFO] Test Case '-[TabOrderTestCase testChildTabOrdering]' passed (23.350 seconds). [03:53:14:INFO] Test Suite 'TabOrderTestCase' passed at 2019-04-20 03:53:14.758. [03:53:14:INFO] Executed 1 test, with 0 failures (0 unexpected) in 23.350 (23.355) seconds [03:53:14:INFO] Test Suite 'VisibleURLTestCase' started at 2019-04-20 03:53:14.759 [03:53:14:INFO] [0420/035314.760405:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:53:14:INFO] Test Case '-[VisibleURLTestCase testBackForwardNavigation]' started. [03:53:16:INFO] [0420/035316.971549:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:53:24:INFO] [0420/035324.413054:WARNING:web_state_impl.mm(661)] Script execution has failed: A JavaScript exception occurred [03:53:27:INFO] Test Case '-[VisibleURLTestCase testBackForwardNavigation]' passed (12.584 seconds). [03:53:27:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingReload]' started. [03:53:33:INFO] [0420/035333.865971:WARNING:web_state_impl.mm(661)] Script execution has failed: A JavaScript exception occurred [03:53:36:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingReload]' passed (9.421 seconds). [03:53:36:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingRendererInitiatedNavigation]' started. [03:53:43:INFO] [0420/035343.177510:WARNING:web_state_impl.mm(661)] Script execution has failed: A JavaScript exception occurred [03:53:46:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingRendererInitiatedNavigation]' passed (9.309 seconds). [03:53:46:INFO] Test Case '-[VisibleURLTestCase testDoubleBackJSNavigation]' started. [03:53:56:INFO] Test Case '-[VisibleURLTestCase testDoubleBackJSNavigation]' passed (10.208 seconds). [03:53:56:INFO] Test Case '-[VisibleURLTestCase testDoubleBackNavigation]' started. [03:54:06:INFO] Test Case '-[VisibleURLTestCase testDoubleBackNavigation]' passed (10.486 seconds). [03:54:06:INFO] Test Case '-[VisibleURLTestCase testDoubleForwardNavigationToWebUIPage]' started. [03:54:18:INFO] Test Case '-[VisibleURLTestCase testDoubleForwardNavigationToWebUIPage]' passed (11.873 seconds). [03:54:18:INFO] Test Case '-[VisibleURLTestCase testHistoryNavigation]' started. [03:54:30:INFO] Test Case '-[VisibleURLTestCase testHistoryNavigation]' passed (11.520 seconds). [03:54:30:INFO] Test Case '-[VisibleURLTestCase testJSBackForwardNavigation]' started. [03:54:42:INFO] Test Case '-[VisibleURLTestCase testJSBackForwardNavigation]' passed (11.901 seconds). [03:54:42:INFO] Test Case '-[VisibleURLTestCase testJSGoNavigation]' started. [03:54:53:INFO] Test Case '-[VisibleURLTestCase testJSGoNavigation]' passed (11.689 seconds). [03:54:53:INFO] Test Case '-[VisibleURLTestCase testRendererInitiatedNavigationWithPendingBackNavigation]' started. [03:55:03:INFO] Test Case '-[VisibleURLTestCase testRendererInitiatedNavigationWithPendingBackNavigation]' passed (9.317 seconds). [03:55:03:INFO] Test Case '-[VisibleURLTestCase testStoppingPendingBackNavigationAndReload]' started. [03:55:12:INFO] Test Case '-[VisibleURLTestCase testStoppingPendingBackNavigationAndReload]' passed (9.648 seconds). [03:55:12:INFO] Test Suite 'VisibleURLTestCase' passed at 2019-04-20 03:55:12.731. [03:55:12:INFO] Executed 11 tests, with 0 failures (0 unexpected) in 117.957 (117.972) seconds [03:55:12:INFO] Test Suite 'WindowOpenByDOMTestCase' started at 2019-04-20 03:55:12.732 [03:55:12:INFO] [0420/035512.733050:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [03:55:12:INFO] Test Case '-[WindowOpenByDOMTestCase testBlockPopupInjectedIntoOpenedWindow]' started. [03:55:14:INFO] [0420/035514.924326:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [03:55:19:INFO] Test Case '-[WindowOpenByDOMTestCase testBlockPopupInjectedIntoOpenedWindow]' passed (6.554 seconds). [03:55:19:INFO] Test Case '-[WindowOpenByDOMTestCase testCloseWindowNotOpenByDOM]' started. [03:55:24:INFO] Test Case '-[WindowOpenByDOMTestCase testCloseWindowNotOpenByDOM]' passed (5.025 seconds). [03:55:24:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTarget]' started. [03:55:31:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTarget]' passed (7.003 seconds). [03:55:31:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetMultipleTimes]' started. [03:55:42:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetMultipleTimes]' passed (10.847 seconds). [03:55:42:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetSessionStorage]' started. [03:55:49:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetSessionStorage]' passed (6.887 seconds). [03:55:49:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithDelayedClose]' started. [03:55:57:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithDelayedClose]' passed (8.380 seconds). [03:55:57:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithImmediateClose]' started. [03:56:03:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithImmediateClose]' passed (6.105 seconds). [03:56:03:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithoutUserGesture]' started. [03:56:08:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithoutUserGesture]' passed (5.451 seconds). [03:56:09:INFO] Test Case '-[WindowOpenByDOMTestCase testLocationReplaceInWindowOpenWithEmptyTarget]' started. [03:56:15:INFO] Test Case '-[WindowOpenByDOMTestCase testLocationReplaceInWindowOpenWithEmptyTarget]' passed (6.446 seconds). [03:56:15:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndAssignToHref]' started. [03:56:21:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndAssignToHref]' passed (6.376 seconds). [03:56:21:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndCallLocationAssign]' started. [03:56:28:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndCallLocationAssign]' passed (6.242 seconds). [03:56:28:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndSetLocation]' started. [03:56:34:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndSetLocation]' passed (6.244 seconds). [03:56:34:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithBlankTarget]' started. [03:56:40:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithBlankTarget]' passed (6.230 seconds). [03:56:40:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithButtonOnClick]' started. [03:56:46:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithButtonOnClick]' passed (6.174 seconds). [03:56:46:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithEmptyTarget]' started. [03:56:52:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithEmptyTarget]' passed (6.250 seconds). [03:56:52:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithMetaRefresh]' started. [03:56:59:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithMetaRefresh]' passed (6.252 seconds). [03:56:59:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithPreventDefaultLink]' started. [03:57:05:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithPreventDefaultLink]' passed (6.698 seconds). [03:57:05:INFO] Test Suite 'WindowOpenByDOMTestCase' passed at 2019-04-20 03:57:05.916. [03:57:05:INFO] Executed 17 tests, with 0 failures (0 unexpected) in 113.165 (113.184) seconds [03:57:05:INFO] Test Suite 'ios_chrome_web_egtests.app' passed at 2019-04-20 03:57:05.916. [03:57:05:INFO] Executed 94 tests, with 0 failures (0 unexpected) in 727.296 (729.303) seconds [03:57:05:INFO] Test Suite 'All tests' passed at 2019-04-20 03:57:05.918. [03:57:05:INFO] Executed 94 tests, with 0 failures (0 unexpected) in 727.296 (729.306) seconds [03:57:06:INFO] [03:57:06:INFO] [03:57:06:INFO] Test session results and logs: [03:57:06:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-hjgbckvkeuxuddbjpnkehtviswbt/Logs/Test/Test-Transient Testing-2019.04.20_03-44-23--0700.xcresult [03:57:06:INFO] [03:57:06:INFO] 2019-04-20 03:57:06.385 xcodebuild[37467:503165] [MT] IDETestOperationsObserverDebug: 762.988 elapsed -- Testing started completed. [03:57:06:INFO] 2019-04-20 03:57:06.385 xcodebuild[37467:503165] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [03:57:06:INFO] 2019-04-20 03:57:06.385 xcodebuild[37467:503165] [MT] IDETestOperationsObserverDebug: 762.988 sec, +762.988 sec -- end [03:57:06:INFO] ** TEST EXECUTE SUCCEEDED ** [03:57:06:INFO] [03:57:10:DEBUG] Finished print_process_output. [03:57:10:INFO] Waiting for test process to terminate. [03:57:10:INFO] Test process terminated. [03:57:10:DEBUG] Setting sigterm handler. [03:57:10:DEBUG] Stdout flushed after test process. [03:57:10:DEBUG] Processing test results. [03:57:10:INFO] /b/s/w/ir/src/out/Debug-iphonesimulator/iossim returned 0 [03:57:10:DEBUG] Extracting test data. [03:57:11:DEBUG] Retrieving crash reports. [03:57:11:DEBUG] Retrieving derived data. [03:57:11:DEBUG] Making desktop screenshots. [03:57:11:DEBUG] Killing simulators. [03:57:16:DEBUG] Wiping simulator. Device wiped. [03:57:18:DEBUG] End of tear_down. 2019-04-20 04:00:55,719 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/k/recipe_cleanup/16y021QI/445329fc5914dd10'] 2019-04-20 04:00:55,719 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/k/recipe_cleanup/16y021QI/445329fc5914dd10/output.json']) Found: [] Expected: ['/b/s/w/ir/k/recipe_cleanup/16y021QI/445329fc5914dd10/output.json'] 2019-04-20 04:00:55,720 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/k/recipe_cleanup/16y021QI' Found ['/b/s/w/ir/k/recipe_cleanup/16y021QI/445329fc5914dd10'] 2019-04-20 04:00:55,720 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/k/recipe_cleanup/16y021QI/445329fc5914dd10/output.json'] 2019-04-20 04:00:55,720 - root: [INFO] merge_cmd: /b/s/w/ir/cache/vpython/5b0713/bin/python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py --summary-json /b/s/w/ir/tmp/t/tmpq9Zxvz.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/16y021QI -o /b/s/w/ir/tmp/t/tmpFA7eBD.json Running ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpq9Zxvz.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/16y021QI', '-o', '/b/s/w/ir/tmp/t/tmpFA7eBD.json'] in None (env: None) Command ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpq9Zxvz.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/16y021QI', '-o', '/b/s/w/ir/tmp/t/tmpFA7eBD.json'] returned exit code 0