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/swarming/resources/collect_task.py --verbose -o /b/s/w/ir/tmp/t/tmpOYZoj8.json --task-output-dir /b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02 --merge-script /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/noop_merge.py --merge-script-stdout-file /b/s/w/ir/tmp/t/tmp1rAO4qmerge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpgch5_n.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/tmp_rzD7I.json in dir /b/s/w/ir/kitchen-workdir: allow_subannotations: False base_name: 'ios_chrome_ui_egtests (iPhone X iOS 12.1) shard 5 on Mac-10.13.6' 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/swarming/resources/collect_task.py', '--verbose', '-o', '/b/s/w/ir/tmp/t/tmpOYZoj8.json', '--task-output-dir', '/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02', '--merge-script', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/noop_merge.py', '--merge-script-stdout-file', '/b/s/w/ir/tmp/t/tmp1rAO4qmerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpgch5_n.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/tmp_rzD7I.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name: 'ios_chrome_ui_egtests (iPhone X iOS 12.1) shard 5 on Mac-10.13.6' nest_level: 0 ok_ret: frozenset([0]) step_test_data: <lambda>(...) trigger_specs: () full environment: Apple_PubSub_Socket_Render: /private/tmp/com.apple.launchd.2Pv7ZuX0UK/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: 49242 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/8921232458092935056 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/itZ1pJvj/luci_context.479161719 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 PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SHELL: /bin/bash SHLVL: 1 SSH_AUTH_SOCK: /private/tmp/com.apple.launchd.TfdzOxDiIG/Listeners SWARMING_BOT_ID: vm140-m9 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 4316a58e64314811 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-02-17 16:11:39,950 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02' 2019-02-17 16:11:39,950 - root: [WARNING] task_output_dir '/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02' already exists! 2019-02-17 16:11:39,950 - root: [WARNING] task_output_dir existing content: [] 2019-02-17 16:11:39,950 - 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/tmp_rzD7I.json -output-dir /b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02 -task-summary-json /b/s/w/ir/tmp/t/tmpgch5_n.json 4316b22a40f53310: exit 0 [I 2019-02-17 15:53:21] About to install Xcode 10b61 in Xcode.app for ios [03:53:22:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer Device wiped. [03:53:33:INFO] User defaults from command line: [03:53:33:INFO] IDETestRunSpecificationPath = /var/folders/2j/22s2gz0s7hn48k32d47clxf80000gm/T/03469759-6A3A-4541-8ADF-3FE093846B24 [03:53:33:INFO] [03:53:33:INFO] Testing started on 'iPhone X' [03:53:33:INFO] 2019-02-17 15:53:33.507 xcodebuild[43755:641692] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [03:53:33:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-geloctkqoaxwtlhkpypdlyvqcdrr/Logs/Test/Test-Transient Testing-2019.02.17_15-53-33--0800.xcresult/1_Test/Diagnostics/ios_chrome_ui_egtests_module-C321F42F-000D-47CA-8CFA-B0BD26EE2814/ios_chrome_ui_egtests_module-3BA1E94F-A50E-4F73-B427-2C1603B542EE/Session-ios_chrome_ui_egtests_module-2019-02-17_155333-8aEa6t.log [03:53:33:INFO] 2019-02-17 15:53:33.507 xcodebuild[43755:641669] [MT] IDETestOperationsObserverDebug: (3B5E31EB-A11C-4731-AC09-63841A7DE664) Beginning test session ios_chrome_ui_egtests_module-3B5E31EB-A11C-4731-AC09-63841A7DE664 at 2019-02-17 15:53:33.507 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7f97deb3f3f0> { [03:53:33:INFO] SimDevice: iPhone X (E02024FA-CAD1-468D-A780-B85D65750508, iOS 12.1, Shutdown) [03:53:33:INFO] } (12.1 (16B91)) [03:53:51:INFO] dyld: warning: could not load inserted library '/b/s/w/ir/Xcode.app/Contents/Developer/Platforms/iPhoneSimulator.platform/Developer/Library/PrivateFrameworks/IDEBundleInjection.framework/IDEBundleInjection' into hardened process because image not found [03:53:52:INFO] 2019-02-17 15:53:52.448 ios_chrome_ui_egtests[43876:642886] Crash handler setup started. [03:53:52:INFO] 2019-02-17 15:53:52.448 ios_chrome_ui_egtests[43876:642886] Crash handler setup completed. [03:53:52:INFO] 2019-02-17 15:53:52.448 ios_chrome_ui_egtests[43876:642886] Enabling accessibility for automation on Simulator. [03:53:55:INFO] 2019-02-17 15:53:55.961 ios_chrome_ui_egtests[43876:642886] Unbalanced calls to begin/end appearance transitions for <TabGridViewController: 0x7fbd29830c00>. [03:53:59:INFO] [0217/155359.281335:WARNING:leveldb_database.cc(111)] Unable to open /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E02024FA-CAD1-468D-A780-B85D65750508/data/Containers/Data/Application/3F5D6440-805D-419A-BFB7-9E8288EE9E4F/Library/Application Support/Chromium/Default/shared_proto_db: Invalid argument: /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E02024FA-CAD1-468D-A780-B85D65750508/data/Containers/Data/Application/3F5D6440-805D-419A-BFB7-9E8288EE9E4F/Library/Application Support/Chromium/Default/shared_proto_db: does not exist (create_if_missing is false) [03:54:03:INFO] Test Suite 'Selected tests' started at 2019-02-17 15:54:03.460 [03:54:03:INFO] Test Suite 'ios_chrome_ui_egtests_module.xctest' started at 2019-02-17 15:54:03.461 [03:54:03:INFO] Test Suite 'SadTabViewTestCase' started at 2019-02-17 15:54:03.461 [03:54:03:INFO] [0217/155403.473897:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:54:05:INFO] Test Case '-[SadTabViewTestCase testSadTabView]' started. [03:54:08:INFO] [0217/155408.683715:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:54:30:INFO] Test Case '-[SadTabViewTestCase testSadTabView]' passed (24.945 seconds). [03:54:30:INFO] Test Suite 'SadTabViewTestCase' passed at 2019-02-17 15:54:30.334. [03:54:30:INFO] Executed 1 test, with 0 failures (0 unexpected) in 24.945 (26.872) seconds [03:54:30:INFO] Test Suite 'SafeModeTestCase' started at 2019-02-17 15:54:30.335 [03:54:30:INFO] [0217/155430.336185:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:54:30:INFO] Test Case '-[SafeModeTestCase testSafeModeBothThirdPartyModsAndHasReport]' started. [03:54:34:INFO] Test Case '-[SafeModeTestCase testSafeModeBothThirdPartyModsAndHasReport]' passed (4.632 seconds). [03:54:34:INFO] Test Case '-[SafeModeTestCase testSafeModeDetectedThirdPartyMods]' started. [03:54:41:INFO] Test Case '-[SafeModeTestCase testSafeModeDetectedThirdPartyMods]' passed (6.350 seconds). [03:54:41:INFO] Test Case '-[SafeModeTestCase testSafeModeSendingCrashReport]' started. [03:54:47:INFO] Test Case '-[SafeModeTestCase testSafeModeSendingCrashReport]' passed (6.535 seconds). [03:54:47:INFO] Test Suite 'SafeModeTestCase' passed at 2019-02-17 15:54:47.860. [03:54:47:INFO] Executed 3 tests, with 0 failures (0 unexpected) in 17.517 (17.525) seconds [03:54:47:INFO] Test Suite 'SaveCardInfobarEGTest' started at 2019-02-17 15:54:47.861 [03:54:47:INFO] [0217/155447.862457:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:54:47:INFO] Test Case '-[SaveCardInfobarEGTest testNotOfferLocalSave_MaxStrikesReached]' started. [03:54:51:INFO] [0217/155451.271304:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:54:52:INFO] [0217/155452.404327:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:54:59:INFO] Test Case '-[SaveCardInfobarEGTest testNotOfferLocalSave_MaxStrikesReached]' passed (11.982 seconds). [03:54:59:INFO] Test Case '-[SaveCardInfobarEGTest testNotOfferLocalSave_PartialData_PaymentsDeclines]' started. [03:55:03:INFO] [0217/155503.790345:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:55:10:INFO] Test Case '-[SaveCardInfobarEGTest testNotOfferLocalSave_PartialData_PaymentsDeclines]' passed (10.943 seconds). [03:55:10:INFO] Test Case '-[SaveCardInfobarEGTest testOfferLocalSave_FullData_PaymentsDeclines_StikeDatabaseDisabled]' started. [03:55:15:INFO] [0217/155515.118286:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:55:16:INFO] 2019-02-17 15:55:16.221 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a4b300> - changing property masksToBounds in transform-only layer, will have no effect [03:55:16:INFO] 2019-02-17 15:55:16.221 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001ba8180> - changing property masksToBounds in transform-only layer, will have no effect [03:55:16:INFO] 2019-02-17 15:55:16.223 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a71b00> - changing property masksToBounds in transform-only layer, will have no effect [03:55:18:INFO] Test Case '-[SaveCardInfobarEGTest testOfferLocalSave_FullData_PaymentsDeclines_StikeDatabaseDisabled]' passed (7.692 seconds). [03:55:18:INFO] Test Case '-[SaveCardInfobarEGTest testOfferLocalSave_FullData_PaymentsDeclines_StikeDatabaseEnabled]' started. [03:55:22:INFO] [0217/155522.440515:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:55:23:INFO] 2019-02-17 15:55:23.539 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a5d960> - changing property masksToBounds in transform-only layer, will have no effect [03:55:23:INFO] 2019-02-17 15:55:23.540 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001b5bfc0> - changing property masksToBounds in transform-only layer, will have no effect [03:55:23:INFO] 2019-02-17 15:55:23.542 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a5c5c0> - changing property masksToBounds in transform-only layer, will have no effect [03:55:25:INFO] Test Case '-[SaveCardInfobarEGTest testOfferLocalSave_FullData_PaymentsDeclines_StikeDatabaseEnabled]' passed (7.365 seconds). [03:55:25:INFO] Test Case '-[SaveCardInfobarEGTest testOfferLocalSave_FullData_RequestFails_StikeDatabaseDisabled]' started. [03:55:30:INFO] [0217/155530.502711:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:55:31:INFO] 2019-02-17 15:55:31.600 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001b46660> - changing property masksToBounds in transform-only layer, will have no effect [03:55:31:INFO] 2019-02-17 15:55:31.601 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a60a80> - changing property masksToBounds in transform-only layer, will have no effect [03:55:31:INFO] 2019-02-17 15:55:31.603 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a84880> - changing property masksToBounds in transform-only layer, will have no effect [03:55:33:INFO] Test Case '-[SaveCardInfobarEGTest testOfferLocalSave_FullData_RequestFails_StikeDatabaseDisabled]' passed (8.011 seconds). [03:55:33:INFO] Test Case '-[SaveCardInfobarEGTest testOfferLocalSave_FullData_RequestFails_StikeDatabaseEnabled]' started. [03:55:38:INFO] [0217/155538.140005:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:55:39:INFO] 2019-02-17 15:55:39.240 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a84b00> - changing property masksToBounds in transform-only layer, will have no effect [03:55:39:INFO] 2019-02-17 15:55:39.240 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a5c600> - changing property masksToBounds in transform-only layer, will have no effect [03:55:39:INFO] 2019-02-17 15:55:39.242 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a7ba40> - changing property masksToBounds in transform-only layer, will have no effect [03:55:41:INFO] Test Case '-[SaveCardInfobarEGTest testOfferLocalSave_FullData_RequestFails_StikeDatabaseEnabled]' passed (7.691 seconds). [03:55:41:INFO] Test Case '-[SaveCardInfobarEGTest testOfferUpstream_FullData_PaymentsAccepts_StikeDatabaseDisabled]' started. [03:55:45:INFO] [0217/155545.949009:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:55:47:INFO] 2019-02-17 15:55:47.051 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a12ee0> - changing property masksToBounds in transform-only layer, will have no effect [03:55:47:INFO] 2019-02-17 15:55:47.052 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a73180> - changing property masksToBounds in transform-only layer, will have no effect [03:55:47:INFO] 2019-02-17 15:55:47.056 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a11da0> - changing property masksToBounds in transform-only layer, will have no effect [03:55:49:INFO] Test Case '-[SaveCardInfobarEGTest testOfferUpstream_FullData_PaymentsAccepts_StikeDatabaseDisabled]' passed (7.792 seconds). [03:55:49:INFO] Test Case '-[SaveCardInfobarEGTest testOfferUpstream_FullData_PaymentsAccepts_StikeDatabaseEnabled]' started. [03:55:53:INFO] [0217/155553.305731:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:55:54:INFO] 2019-02-17 15:55:54.407 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a5d600> - changing property masksToBounds in transform-only layer, will have no effect [03:55:54:INFO] 2019-02-17 15:55:54.408 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a22d40> - changing property masksToBounds in transform-only layer, will have no effect [03:55:54:INFO] 2019-02-17 15:55:54.411 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a11d80> - changing property masksToBounds in transform-only layer, will have no effect [03:55:56:INFO] Test Case '-[SaveCardInfobarEGTest testOfferUpstream_FullData_PaymentsAccepts_StikeDatabaseEnabled]' passed (7.401 seconds). [03:55:56:INFO] Test Case '-[SaveCardInfobarEGTest testOfferUpstream_PartialData_PaymentsAccepts_StikeDatabaseDisabled]' started. [03:56:01:INFO] [0217/155601.371098:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:56:02:INFO] 2019-02-17 15:56:02.476 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001bafe40> - changing property masksToBounds in transform-only layer, will have no effect [03:56:02:INFO] 2019-02-17 15:56:02.477 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001b4d8c0> - changing property masksToBounds in transform-only layer, will have no effect [03:56:02:INFO] 2019-02-17 15:56:02.480 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a8f2c0> - changing property masksToBounds in transform-only layer, will have no effect [03:56:04:INFO] Test Case '-[SaveCardInfobarEGTest testOfferUpstream_PartialData_PaymentsAccepts_StikeDatabaseDisabled]' passed (8.013 seconds). [03:56:04:INFO] Test Case '-[SaveCardInfobarEGTest testOfferUpstream_PartialData_PaymentsAccepts_StikeDatabaseEnabled]' started. [03:56:08:INFO] [0217/155608.664903:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:56:09:INFO] 2019-02-17 15:56:09.798 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001ba78e0> - changing property masksToBounds in transform-only layer, will have no effect [03:56:09:INFO] 2019-02-17 15:56:09.799 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a8d2a0> - changing property masksToBounds in transform-only layer, will have no effect [03:56:09:INFO] 2019-02-17 15:56:09.802 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a8b920> - changing property masksToBounds in transform-only layer, will have no effect [03:56:12:INFO] Test Case '-[SaveCardInfobarEGTest testOfferUpstream_PartialData_PaymentsAccepts_StikeDatabaseEnabled]' passed (7.369 seconds). [03:56:12:INFO] Test Case '-[SaveCardInfobarEGTest testUMA_Upstream_UserAccepts]' started. [03:56:15:INFO] 2019-02-17 15:56:15.255 ios_chrome_ui_egtests[43876:642886] -- Earl Grey Test Disabled -- Test disabled. [03:56:17:INFO] Test Case '-[SaveCardInfobarEGTest testUMA_Upstream_UserAccepts]' passed (5.039 seconds). [03:56:17:INFO] Test Case '-[SaveCardInfobarEGTest testUMA_Upstream_UserDeclines_StikeDatabaseDisabled]' started. [03:56:20:INFO] 2019-02-17 15:56:20.608 ios_chrome_ui_egtests[43876:642886] -- Earl Grey Test Disabled -- Failing regularly on the bots. [03:56:22:INFO] Test Case '-[SaveCardInfobarEGTest testUMA_Upstream_UserDeclines_StikeDatabaseDisabled]' passed (5.350 seconds). [03:56:22:INFO] Test Case '-[SaveCardInfobarEGTest testUMA_Upstream_UserDeclines_StikeDatabaseEnabled]' started. [03:56:25:INFO] 2019-02-17 15:56:25.868 ios_chrome_ui_egtests[43876:642886] -- Earl Grey Test Disabled -- Failing regularly on the bots. [03:56:27:INFO] Test Case '-[SaveCardInfobarEGTest testUMA_Upstream_UserDeclines_StikeDatabaseEnabled]' passed (5.261 seconds). [03:56:27:INFO] Test Case '-[SaveCardInfobarEGTest testUserData_LocalSave_UserAccepts]' started. [03:56:32:INFO] [0217/155632.159962:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /credit_card_upload_done.html [03:56:33:INFO] 2019-02-17 15:56:33.258 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001b4e120> - changing property masksToBounds in transform-only layer, will have no effect [03:56:33:INFO] 2019-02-17 15:56:33.258 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001a82d80> - changing property masksToBounds in transform-only layer, will have no effect [03:56:33:INFO] 2019-02-17 15:56:33.261 ios_chrome_ui_egtests[43876:642886] <CATransformLayer: 0x600001b4d0c0> - changing property masksToBounds in transform-only layer, will have no effect [03:56:34:INFO] 2019-02-17 15:56:34.897 ios_chrome_ui_egtests[43876:642886] Button touch target does not meet minimum size guidlines of (48, 48). Button: <MDCFlatButton: 0x7fbd2b251b50; baseClass = UIButton; frame = (288 32; 71 37); opaque = NO; tintColor = UIExtendedGrayColorSpace 1 1; layer = <MDCShapedShadowLayer: 0x600003523c80>>, Touch Target: {71, 37} [03:56:37:INFO] Test Case '-[SaveCardInfobarEGTest testUserData_LocalSave_UserAccepts]' passed (9.431 seconds). [03:56:37:INFO] Test Case '-[SaveCardInfobarEGTest testUserData_LocalSave_UserDeclines_StikeDatabaseDisabled]' started. [03:56:39:INFO] 2019-02-17 15:56:39.953 ios_chrome_ui_egtests[43876:642886] -- Earl Grey Test Disabled -- Failing regularly on the bots. [03:56:41:INFO] Test Case '-[SaveCardInfobarEGTest testUserData_LocalSave_UserDeclines_StikeDatabaseDisabled]' passed (4.656 seconds). [03:56:41:INFO] Test Case '-[SaveCardInfobarEGTest testUserData_LocalSave_UserDeclines_StikeDatabaseEnabled]' started. [03:56:45:INFO] 2019-02-17 15:56:45.590 ios_chrome_ui_egtests[43876:642886] -- Earl Grey Test Disabled -- Failing regularly on the bots. [03:56:47:INFO] Test Case '-[SaveCardInfobarEGTest testUserData_LocalSave_UserDeclines_StikeDatabaseEnabled]' passed (5.637 seconds). [03:56:47:INFO] Test Suite 'SaveCardInfobarEGTest' passed at 2019-02-17 15:56:47.534. [03:56:47:INFO] Executed 16 tests, with 0 failures (0 unexpected) in 119.632 (119.673) seconds [03:56:47:INFO] Test Suite 'SaveProfileEGTest' started at 2019-02-17 15:56:47.535 [03:56:47:INFO] [0217/155647.536035:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:56:47:INFO] Test Case '-[SaveProfileEGTest testUserData_LocalSave]' started. [03:56:51:INFO] [0217/155651.280960:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:56:55:INFO] Test Case '-[SaveProfileEGTest testUserData_LocalSave]' passed (7.802 seconds). [03:56:55:INFO] Test Suite 'SaveProfileEGTest' passed at 2019-02-17 15:56:55.343. [03:56:55:INFO] Executed 1 test, with 0 failures (0 unexpected) in 7.802 (7.808) seconds [03:56:55:INFO] Test Suite 'ShortcutsTestCase' started at 2019-02-17 15:56:55.344 [03:56:55:INFO] [0217/155655.345035:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:56:55:INFO] Test Case '-[ShortcutsTestCase testBookmarksShortcut]' started. [03:56:59:INFO] [0217/155659.065241:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:57:26:INFO] Test Case '-[ShortcutsTestCase testBookmarksShortcut]' passed (30.896 seconds). [03:57:26:INFO] Test Case '-[ShortcutsTestCase testHistoryShortcut]' started. [03:57:30:INFO] [0217/155730.253978:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:57:57:INFO] Test Case '-[ShortcutsTestCase testHistoryShortcut]' passed (31.025 seconds). [03:57:57:INFO] Test Case '-[ShortcutsTestCase testNotShownWhenSuggestionsAvailable]' started. [03:58:01:INFO] [0217/155801.015791:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:58:12:INFO] 2019-02-17 15:58:12.358 ios_chrome_ui_egtests[43876:642886] Attempting to type key f. [03:58:12:INFO] 2019-02-17 15:58:12.359 ios_chrome_ui_egtests[43876:642886] Tapping on key: f. [03:58:12:INFO] 2019-02-17 15:58:12.490 ios_chrome_ui_egtests[43876:642886] Attempting to type key o. [03:58:12:INFO] 2019-02-17 15:58:12.491 ios_chrome_ui_egtests[43876:642886] Tapping on key: o. [03:58:12:INFO] 2019-02-17 15:58:12.548 ios_chrome_ui_egtests[43876:642886] Attempting to type key o. [03:58:12:INFO] 2019-02-17 15:58:12.549 ios_chrome_ui_egtests[43876:642886] Tapping on key: o. [03:58:15:INFO] Test Case '-[ShortcutsTestCase testNotShownWhenSuggestionsAvailable]' passed (18.473 seconds). [03:58:15:INFO] Test Case '-[ShortcutsTestCase testNTPShortcutsDontShowUp]' started. [03:58:19:INFO] [0217/155819.571661:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:58:41:INFO] Test Case '-[ShortcutsTestCase testNTPShortcutsDontShowUp]' passed (25.667 seconds). [03:58:41:INFO] Test Case '-[ShortcutsTestCase testReadingListShortcut]' started. [03:58:45:INFO] [0217/155845.227394:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:59:13:INFO] Test Case '-[ShortcutsTestCase testReadingListShortcut]' passed (31.599 seconds). [03:59:13:INFO] Test Case '-[ShortcutsTestCase testRecentTabsShortcut]' started. [03:59:16:INFO] [0217/155916.802676:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:59:43:INFO] Test Case '-[ShortcutsTestCase testRecentTabsShortcut]' passed (30.693 seconds). [03:59:43:INFO] Test Case '-[ShortcutsTestCase testShowsUp]' started. [03:59:47:INFO] [0217/155947.423664:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:00:03:INFO] Test Case '-[ShortcutsTestCase testShowsUp]' passed (20.093 seconds). [04:00:03:INFO] Test Case '-[ShortcutsTestCase testShowsUpWhenOmniboxIsEmpty]' started. [04:00:08:INFO] [0217/160008.053599:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:00:18:INFO] 2019-02-17 16:00:18.074 ios_chrome_ui_egtests[43876:642886] Attempting to type key . [04:00:18:INFO] 2019-02-17 16:00:18.075 ios_chrome_ui_egtests[43876:642886] Tapping on key: delete. [04:00:25:INFO] Test Case '-[ShortcutsTestCase testShowsUpWhenOmniboxIsEmpty]' passed (21.230 seconds). [04:00:25:INFO] Test Case '-[ShortcutsTestCase testTapMostVisitedTile]' started. [04:00:29:INFO] [0217/160029.239975:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:00:45:INFO] Test Case '-[ShortcutsTestCase testTapMostVisitedTile]' passed (20.589 seconds). [04:00:45:INFO] Test Suite 'ShortcutsTestCase' passed at 2019-02-17 16:00:45.621. [04:00:45:INFO] Executed 9 tests, with 0 failures (0 unexpected) in 230.267 (230.277) seconds [04:00:45:INFO] Test Suite 'SideSwipeTestCase' started at 2019-02-17 16:00:45.621 [04:00:45:INFO] [0217/160045.623151:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [04:00:45:INFO] Test Case '-[SideSwipeTestCase testSideSwipeBottomToolbar]' started. [04:00:48:INFO] [0217/160048.129004:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:01:04:INFO] Test Case '-[SideSwipeTestCase testSideSwipeBottomToolbar]' passed (18.730 seconds). [04:01:04:INFO] Test Case '-[SideSwipeTestCase testSideSwipeTopToolbar]' started. [04:01:07:INFO] [0217/160107.753565:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:01:25:INFO] Test Case '-[SideSwipeTestCase testSideSwipeTopToolbar]' passed (21.128 seconds). [04:01:25:INFO] Test Suite 'SideSwipeTestCase' passed at 2019-02-17 16:01:25.489. [04:01:25:INFO] Executed 2 tests, with 0 failures (0 unexpected) in 39.858 (39.868) seconds [04:01:25:INFO] Test Suite 'SigninInteractionControllerTestCase' started at 2019-02-17 16:01:25.490 [04:01:25:INFO] [0217/160125.492041:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [04:01:25:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInCancelAddAccount]' started. [04:02:11:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInCancelAddAccount]' passed (46.202 seconds). [04:02:11:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInCancelAuthenticationFlow]' started. [04:02:30:INFO] [0217/160230.907739:WARNING:sync_encryption_handler_impl.cc(1080)] Nigori had empty encryption keybag. [04:02:30:INFO] [0217/160230.918772:WARNING:sync_encryption_handler_impl.cc(1080)] Nigori had empty encryption keybag. [04:02:30:INFO] [0217/160230.940167:ERROR:account_tracker.cc(264)] OnOAuthError [04:02:30:INFO] [0217/160230.940325:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID [04:02:30:INFO] [0217/160230.983401:ERROR:account_tracker.cc(264)] OnOAuthError [04:02:30:INFO] [0217/160230.983583:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo2ID [04:02:34:INFO] [0217/160234.544693:INFO:profile_sync_service.cc(1926)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [04:02:55:INFO] [0217/160255.943236:INFO:signin_manager.cc(124)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1 [04:03:31:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInCancelAuthenticationFlow]' passed (80.035 seconds). [04:03:31:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInCancelFromBookmarks]' started. [04:04:16:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInCancelFromBookmarks]' passed (44.691 seconds). [04:04:16:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInCancelIdentityPicker]' started. [04:04:55:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInCancelIdentityPicker]' passed (38.568 seconds). [04:04:55:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInDisconnectFromChrome]' started. [04:05:16:INFO] [0217/160516.307265:ERROR:account_tracker.cc(264)] OnOAuthError [04:05:16:INFO] [0217/160516.307444:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID [04:05:20:INFO] [0217/160520.706929:INFO:profile_sync_service.cc(1926)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [04:05:20:INFO] [0217/160520.833156:WARNING:session_sync_bridge.cc(237)] Dropping modification to local session. [04:05:44:INFO] [0217/160544.672547:INFO:signin_manager.cc(124)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1 [04:05:52:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInDisconnectFromChrome]' passed (57.405 seconds). [04:05:52:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInOneUser]' started. [04:06:13:INFO] [0217/160613.235483:ERROR:account_tracker.cc(264)] OnOAuthError [04:06:13:INFO] [0217/160613.235697:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID [04:06:17:INFO] [0217/160617.677640:INFO:profile_sync_service.cc(1926)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [04:06:17:INFO] [0217/160617.786148:WARNING:session_sync_bridge.cc(237)] Dropping modification to local session. [04:06:22:INFO] [0217/160622.767817:INFO:signin_manager.cc(124)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1 [04:06:25:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInOneUser]' passed (32.624 seconds). [04:06:25:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInOpenSettings]' started. [04:06:43:INFO] [0217/160643.227785:ERROR:account_tracker.cc(264)] OnOAuthError [04:06:43:INFO] [0217/160643.227919:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID [04:06:55:INFO] [0217/160655.825822:INFO:profile_sync_service.cc(1926)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [04:06:55:INFO] [0217/160655.979777:WARNING:session_sync_bridge.cc(237)] Dropping modification to local session. [04:06:57:INFO] [0217/160657.570376:INFO:signin_manager.cc(124)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1 [04:06:59:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInOpenSettings]' passed (34.775 seconds). [04:06:59:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInSwitchAccountsAndImportData]' started. [04:07:19:INFO] [0217/160719.219701:WARNING:http_cache_transaction.cc(1276)] Unable to create cache entry [04:07:19:INFO] [0217/160719.271412:ERROR:account_tracker.cc(264)] OnOAuthError [04:07:19:INFO] [0217/160719.271558:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo2ID [04:07:19:INFO] [0217/160719.272547:ERROR:account_tracker.cc(264)] OnOAuthError [04:07:19:INFO] [0217/160719.272675:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID [04:07:22:INFO] [0217/160722.040892:INFO:profile_sync_service.cc(1926)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [04:07:22:INFO] [0217/160722.122431:WARNING:session_sync_bridge.cc(237)] Dropping modification to local session. [04:07:53:INFO] [0217/160753.935539:INFO:signin_manager.cc(124)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1 [04:07:54:INFO] [0217/160754.343293:ERROR:account_tracker.cc(264)] OnOAuthError [04:07:54:INFO] [0217/160754.343503:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID [04:07:54:INFO] [0217/160754.345832:ERROR:account_tracker.cc(264)] OnOAuthError [04:07:54:INFO] [0217/160754.345992:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo2ID [04:07:57:INFO] [0217/160757.672548:INFO:profile_sync_service.cc(1926)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [04:07:57:INFO] [0217/160757.792299:WARNING:model_type_controller.cc(204)] Deferring stop for Bookmarks because it's still starting [04:07:57:INFO] [0217/160757.806016:WARNING:model_type_controller.cc(204)] Deferring stop for Reading List because it's still starting [04:07:57:INFO] [0217/160757.806194:WARNING:model_type_controller.cc(204)] Deferring stop for User Events because it's still starting [04:07:57:INFO] [0217/160757.806314:WARNING:model_type_controller.cc(204)] Deferring stop for User Consents because it's still starting [04:07:57:INFO] [0217/160757.806539:INFO:profile_sync_service.cc(1176)] ProfileSyncService::Observe Sync Configure aborted [04:07:57:INFO] [0217/160757.811488:INFO:signin_manager.cc(124)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1 [04:08:01:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInSwitchAccountsAndImportData]' passed (61.517 seconds). [04:08:01:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInSwitchAccountsAndKeepDataSeparate]' started. [04:08:20:INFO] [0217/160820.361986:ERROR:account_tracker.cc(264)] OnOAuthError [04:08:20:INFO] [0217/160820.362118:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID [04:08:20:INFO] [0217/160820.393227:ERROR:account_tracker.cc(264)] OnOAuthError [04:08:20:INFO] [0217/160820.393375:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo2ID [04:08:23:INFO] [0217/160823.954996:INFO:profile_sync_service.cc(1926)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [04:08:24:INFO] [0217/160824.035672:WARNING:session_sync_bridge.cc(237)] Dropping modification to local session. [04:08:51:INFO] [0217/160851.746538:INFO:signin_manager.cc(124)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1 [04:08:51:INFO] [0217/160851.822436:WARNING:leveldb_database.cc(111)] Unable to open /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E02024FA-CAD1-468D-A780-B85D65750508/data/Containers/Data/Application/3F5D6440-805D-419A-BFB7-9E8288EE9E4F/Library/Application Support/Chromium/Default/AutofillStrikeDatabase: IO error: /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/E02024FA-CAD1-468D-A780-B85D65750508/data/Containers/Data/Application/3F5D6440-805D-419A-BFB7-9E8288EE9E4F/Library/Application Support/Chromium/Default/AutofillStrikeDatabase/LOCK: Lock file already locked. (ChromeMethodOnly: 15::LockFile) [04:08:52:INFO] [0217/160852.444256:ERROR:account_tracker.cc(264)] OnOAuthError [04:08:52:INFO] [0217/160852.444389:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID [04:08:52:INFO] [0217/160852.450641:ERROR:account_tracker.cc(264)] OnOAuthError [04:08:52:INFO] [0217/160852.450765:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo2ID [04:08:56:INFO] [0217/160856.822314:INFO:profile_sync_service.cc(1926)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [04:08:56:INFO] [0217/160856.909232:WARNING:model_type_controller.cc(204)] Deferring stop for Reading List because it's still starting [04:08:56:INFO] [0217/160856.909402:WARNING:model_type_controller.cc(204)] Deferring stop for User Events because it's still starting [04:08:56:INFO] [0217/160856.909516:WARNING:model_type_controller.cc(204)] Deferring stop for User Consents because it's still starting [04:08:56:INFO] [0217/160856.909670:INFO:profile_sync_service.cc(1176)] ProfileSyncService::Observe Sync Configure aborted [04:08:56:INFO] [0217/160856.913085:INFO:signin_manager.cc(124)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1 [04:09:00:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInSwitchAccountsAndKeepDataSeparate]' passed (59.092 seconds). [04:09:00:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInSwitchManagedAccount]' started. [04:09:22:INFO] [0217/160922.287590:ERROR:account_tracker.cc(264)] OnOAuthError [04:09:22:INFO] [0217/160922.287718:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID [04:09:22:INFO] [0217/160922.333924:ERROR:account_tracker.cc(264)] OnOAuthError [04:09:22:INFO] [0217/160922.334054:WARNING:account_tracker.cc(190)] Failed to get UserInfo for fooManagedID [04:09:26:INFO] [0217/160926.757173:INFO:profile_sync_service.cc(1926)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [04:09:26:INFO] [0217/160926.870371:WARNING:session_sync_bridge.cc(237)] Dropping modification to local session. [04:09:44:INFO] [0217/160944.248131:INFO:signin_manager.cc(124)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1 [04:09:45:INFO] [0217/160945.363923:ERROR:account_tracker.cc(264)] OnOAuthError [04:09:45:INFO] [0217/160945.364068:WARNING:account_tracker.cc(190)] Failed to get UserInfo for foo1ID [04:09:45:INFO] [0217/160945.368185:ERROR:account_tracker.cc(264)] OnOAuthError [04:09:45:INFO] [0217/160945.368296:WARNING:account_tracker.cc(190)] Failed to get UserInfo for fooManagedID [04:09:49:INFO] [0217/160949.607535:INFO:profile_sync_service.cc(1926)] ConfigureDataTypeManager not invoked because datatypes cannot be configured now [04:09:49:INFO] [0217/160949.704968:WARNING:model_type_controller.cc(204)] Deferring stop for Reading List because it's still starting [04:09:49:INFO] [0217/160949.705147:WARNING:model_type_controller.cc(204)] Deferring stop for User Events because it's still starting [04:09:49:INFO] [0217/160949.705268:WARNING:model_type_controller.cc(204)] Deferring stop for User Consents because it's still starting [04:09:49:INFO] [0217/160949.705429:INFO:profile_sync_service.cc(1176)] ProfileSyncService::Observe Sync Configure aborted [04:09:49:INFO] [0217/160949.708651:INFO:signin_manager.cc(124)] Revoking all refresh tokens on server. Reason: sign out, IsSigninAllowed: 1 [04:09:53:INFO] Test Case '-[SigninInteractionControllerTestCase testSignInSwitchManagedAccount]' passed (52.798 seconds). [04:09:53:INFO] Test Suite 'SigninInteractionControllerTestCase' passed at 2019-02-17 16:09:53.225. [04:09:53:INFO] Executed 10 tests, with 0 failures (0 unexpected) in 507.707 (507.735) seconds [04:09:53:INFO] Test Suite 'TabStripTestCase' started at 2019-02-17 16:09:53.227 [04:09:53:INFO] [0217/160953.228498:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [04:09:53:INFO] Test Case '-[TabStripTestCase testTabStripSwitchTabs]' started. [04:09:58:INFO] Test Case '-[TabStripTestCase testTabStripSwitchTabs]' passed (5.104 seconds). [04:09:58:INFO] Test Suite 'TabStripTestCase' passed at 2019-02-17 16:09:58.352. [04:09:58:INFO] Executed 1 test, with 0 failures (0 unexpected) in 5.104 (5.125) seconds [04:09:58:INFO] Test Suite 'ios_chrome_ui_egtests_module.xctest' passed at 2019-02-17 16:09:58.353. [04:09:58:INFO] Executed 43 tests, with 0 failures (0 unexpected) in 952.831 (954.892) seconds [04:09:58:INFO] Test Suite 'Selected tests' passed at 2019-02-17 16:09:58.354. [04:09:58:INFO] Executed 43 tests, with 0 failures (0 unexpected) in 952.831 (954.894) seconds [04:09:58:INFO] [04:09:58:INFO] [04:09:58:INFO] Test session results and logs: [04:09:58:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-geloctkqoaxwtlhkpypdlyvqcdrr/Logs/Test/Test-Transient Testing-2019.02.17_15-53-33--0800.xcresult [04:09:58:INFO] [04:09:58:INFO] 2019-02-17 16:09:58.717 xcodebuild[43755:641669] [MT] IDETestOperationsObserverDebug: 985.323 elapsed -- Testing started completed. [04:09:58:INFO] 2019-02-17 16:09:58.717 xcodebuild[43755:641669] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [04:09:58:INFO] 2019-02-17 16:09:58.717 xcodebuild[43755:641669] [MT] IDETestOperationsObserverDebug: 985.323 sec, +985.323 sec -- end [04:09:58:INFO] ** TEST EXECUTE SUCCEEDED ** [04:09:58:INFO] [04:10:05:INFO] Break line finished! [04:10:05:DEBUG] Finished print_process_output. [04:10:05:INFO] Waiting for test process to terminate. [04:10:05:INFO] Test process terminated. [04:10:05:DEBUG] Stdout flushed after test process. [04:10:05:DEBUG] Processing test results. [04:10:05:INFO] /b/s/w/ir/src/out/Debug-iphonesimulator/iossim returned 0 [04:10:05:DEBUG] Extracting test data. [04:10:05:DEBUG] Retrieving crash reports. [04:10:05:DEBUG] Retrieving derived data. [04:10:05:DEBUG] Making desktop screenshots. [04:10:05:DEBUG] Killing simulators. [04:10:10:DEBUG] Wiping simulator. Device wiped. [04:10:13:DEBUG] End of tear_down. 2019-02-17 16:11:40,999 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02/4316b22a40f53310'] 2019-02-17 16:11:40,999 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02/4316b22a40f53310/output.json']) Found: [] Expected: ['/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02/4316b22a40f53310/output.json'] 2019-02-17 16:11:41,000 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02' Found ['/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02/4316b22a40f53310'] 2019-02-17 16:11:41,000 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02/4316b22a40f53310/output.json'] 2019-02-17 16:11:41,000 - root: [INFO] merge_cmd: /b/s/w/ir/cache/vpython/5b0713/bin/python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/noop_merge.py --summary-json /b/s/w/ir/tmp/t/tmpgch5_n.json --task-output-dir /b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02 -o /b/s/w/ir/tmp/t/tmpOYZoj8.json Running ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpgch5_n.json', '--task-output-dir', '/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02', '-o', '/b/s/w/ir/tmp/t/tmpOYZoj8.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/swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpgch5_n.json', '--task-output-dir', '/b/s/w/ir/kitchen-workdir/recipe_cleanup/1_54rJY02', '-o', '/b/s/w/ir/tmp/t/tmpOYZoj8.json'] returned exit code 0