Cannot start public session the first time after demo mode setup [M70] |
||
Issue descriptionVersion: R70-11021.34.0 What steps will reproduce the problem? (1) Run demo mode setup device What is the expected result? Public session starts automatically What happens instead? There is sing-in error notification, public session does not start automatically, public session does not start after manual start. Everything works fine after reboot. We observed that in BBY on 2 different devices (one of them was celes). Unfortunately, sent feedback report did not make it. I cannot repro locally on the same build - tried on eve.
,
Oct 5
Let's see if we can get test to repro it.
,
Oct 17
I got celes device and I have some repro. [1182:1182:1017/132304.998461:VERBOSE1:wizard_controller.cc(625)] Showing demo mode setup screen. [1182:1182:1017/132304.998510:VERBOSE1:wizard_controller.cc(1357)] SetCurrentScreenSmooth: demo-setup [1182:1182:1017/132305.001414:VERBOSE1:demo_setup_controller.cc(164)] Starting demo mode enrollment online [1182:1182:1017/132315.370861:VERBOSE1:component_updater_service.cc(322)] CheckForUpdates: automatic updatecheck for components. [1182:1182:1017/132401.648261:ERROR:device_event_log_impl.cc(159)] [13:24:01.648] Network: network_portal_detector_impl.cc:483 Portal detection timeout: name=GoogleGuest id=5a68338e-d913-4ef2-9298-e3dafe6f5561 [1182:1182:1017/132412.128192:ERROR:device_event_log_impl.cc(159)] [13:24:12.128] Network: network_portal_detector_impl.cc:483 Portal detection timeout: name=GoogleGuest id=5a68338e-d913-4ef2-9298-e3dafe6f5561 [1182:1182:1017/132427.601208:ERROR:device_event_log_impl.cc(159)] [13:24:27.601] Network: network_portal_detector_impl.cc:483 Portal detection timeout: name=GoogleGuest id=5a68338e-d913-4ef2-9298-e3dafe6f5561 [1182:1182:1017/132433.472582:WARNING:object_proxy.cc(613)] Failed to call method: org.chromium.flimflam.IPConfig.GetProperties: object_path= /ipconfig/wlan0_3_dhcp: org.freedesktop.DBus.Error.UnknownObject: Method "GetProperties" with signature "" on interface "org.chromium.flimflam.IPConfig" doesn't exist [1182:1182:1017/132433.508830:WARNING:object_proxy.cc(613)] Failed to call method: org.chromium.flimflam.IPConfig.GetProperties: object_path= /ipconfig/wlan0_6_ip: org.freedesktop.DBus.Error.UnknownObject: Method "GetProperties" with signature "" on interface "org.chromium.flimflam.IPConfig" doesn't exist [1182:1182:1017/132433.801240:VERBOSE1:signin_screen_handler.cc(597)] OnNetworkReady() call. [1182:1182:1017/132519.508851:VERBOSE1:component_updater_service.cc(409)] Update completed with error 0 [1182:1182:1017/132521.120998:VERBOSE1:component_updater_service.cc(409)] Update completed with error 0 [1182:1182:1017/132521.163156:VERBOSE1:component_updater_service.cc(409)] Update completed with error 0 [1402:1419:1017/132533.494060:WARNING:screen_manager.cc(114)] Display controller (crtc=31) already present. [1402:1419:1017/132533.495063:VERBOSE1:drm_display.cc(104)] DRM configuring: device=/sys/devices/pci0000:00/0000:00:02.0/drm/card0 crtc=31 connector=47 origin=0,0 size=0x0 [1182:1182:1017/132539.660477:INFO:remote_commands_service.cc(38)] Fetching remote commands. [1182:1182:1017/132539.662514:INFO:system_log_uploader.cc(237)] Creating system log uploader. [1182:1182:1017/132539.664346:INFO:system_log_uploader.cc(389)] Scheduling next system log upload 0 s from now. [1182:1182:1017/132539.691490:INFO:system_log_uploader.cc(359)] System log upload is disabled, rescheduling. [1182:1182:1017/132539.692586:INFO:system_log_uploader.cc(389)] Scheduling next system log upload 43200 s from now. [1182:1182:1017/132539.692986:ERROR:object_proxy.cc(615)] Failed to call method: org.chromium.UpdateEngineInterface.SetChannel: object_path= /org/chromium/UpdateEngine: org.freedesktop.DBus.Error.Failed: update_engine/org.chromium.UpdateEngine.Error.Failed:Cannot set target channel explicitly when channel policy/settings is not delegated [1182:1182:1017/132539.693041:ERROR:update_engine_client.cc(396)] Failed to request setting channel [1182:1182:1017/132539.694170:VERBOSE1:demo_setup_controller.cc(382)] Demo mode setup finished successfully. [1182:1182:1017/132539.696467:VERBOSE1:wizard_controller.cc(1529)] Wizard screen exit code: DEMO_MODE_SETUP_FINISHED [1182:1182:1017/132539.700590:VERBOSE1:wizard_controller.cc(570)] Showing login screen. [1182:1182:1017/132539.701143:VERBOSE1:login_display_host_webui.cc(628)] Login WebUI >> sign in [1182:1182:1017/132539.865531:WARNING:device_management_service.cc(312)] DMServer sent an error response: 902 [1182:1182:1017/132539.866095:WARNING:device_management_service.cc(312)] DMServer sent an error response: 902 [1182:1182:1017/132539.888488:INFO:signin_screen_handler.cc(1485)] Login WebUI >> active: 1, source: account-picker [1182:1182:1017/132539.959904:INFO:remote_commands_service.cc(165)] Remote commands fetched. [1182:1182:1017/132540.126064:ERROR:proximity_auth_local_state_pref_manager.cc(146)] Failed to find prefs for current user. [1182:1182:1017/132540.126177:ERROR:proximity_auth_local_state_pref_manager.cc(80)] Failed to get easyunlock_allowed. [1182:1182:1017/132540.126223:ERROR:proximity_auth_local_state_pref_manager.cc(146)] Failed to find prefs for current user. [1182:1182:1017/132540.126266:ERROR:proximity_auth_local_state_pref_manager.cc(92)] Failed to get easyunlock_enabled. [1182:1182:1017/132540.493473:INFO:signin_screen_handler.cc(1373)] Login WebUI >> AccountPickerReady [1182:1182:1017/132540.493960:VERBOSE1:gaia_screen_handler.cc(314)] MaybePreloadAuthExtension [1182:1182:1017/132540.494113:VERBOSE1:gaia_screen_handler.cc(1171)] LoadAuthExtension, force: 1, offline: 0 [1182:1182:1017/132540.495192:VERBOSE1:signin_screen_handler.cc(1439)] Login WebUI >> loginVisible, src: account-picker, webui_visible_: 1 [1182:1182:1017/132540.501344:VERBOSE1:existing_user_controller.cc(1497)] [1182:1182:1017/132540.501436:VERBOSE1:login_display_webui.cc(109)] Show error, error_id: 2273, attempts:1, help_topic_id: 188036 [1182:1182:1017/132540.501477:ERROR:core_oobe_handler.cc(236)] CoreOobeHandler::ShowSignInError: error_text=Sign-in failed, please connect to the internet and try again. [1182:1182:1017/132540.785049:VERBOSE1:gaia_screen_handler.cc(596)] OnPortalDetectionCompleted Online [1182:1182:1017/132540.806915:VERBOSE1:gaia_screen_handler.cc(621)] Auth extension finished loading [1182:1182:1017/132541.075018:INFO:remote_commands_invalidator.cc(32)] Initialize RemoteCommandsInvalidator. [1182:1182:1017/132541.075313:INFO:remote_commands_invalidator.cc(57)] Starting RemoteCommandsInvalidator. [1182:1182:1017/132541.075928:INFO:remote_commands_invalidator.cc(123)] RemoteCommandsInvalidator ReloadPolicyData. [1182:1182:1017/132541.076038:INFO:remote_commands_invalidator.cc(147)] Register RemoteCommandsInvalidator. [1182:1182:1017/132541.076573:INFO:remote_commands_invalidator.cc(83)] RemoteCommandsInvalidator state changed: 3 [1182:1182:1017/132541.076961:INFO:remote_commands_invalidator.cc(83)] RemoteCommandsInvalidator state changed: 3 [1182:1182:1017/132542.331203:INFO:remote_commands_invalidator.cc(94)] RemoteCommandsInvalidator received invalidation. [1182:1182:1017/132542.331408:INFO:remote_commands_invalidator.cc(110)] Invalidations acknowledged. [1182:1182:1017/132542.331478:INFO:remote_commands_service.cc(38)] Fetching remote commands. [1182:1182:1017/132542.487133:INFO:remote_commands_service.cc(165)] Remote commands fetched. [1182:1182:1017/132543.316458:VERBOSE1:gaia_screen_handler.cc(803)] Gaia is loaded [1182:1182:1017/132543.316995:VERBOSE1:signin_screen_handler.cc(1439)] Login WebUI >> loginVisible, src: gaia-signin, webui_visible_: 1 [1182:1182:1017/132543.317360:VERBOSE1:existing_user_controller.cc(1497)] [1182:1182:1017/132543.317402:VERBOSE1:login_display_webui.cc(109)] Show error, error_id: 2273, attempts:2, help_topic_id: 188036 [1182:1182:1017/132543.317448:ERROR:core_oobe_handler.cc(236)] CoreOobeHandler::ShowSignInError: error_text=Sign-in failed, please connect to the internet and try again. [1182:1182:1017/132543.317889:WARNING:CONSOLE(19045)] "Unrecognized message from GAIA: showConfirmCancel", source: chrome://oobe/oobe.js (19045) [1402:1419:1017/132558.839130:WARNING:screen_manager.cc(114)] Display controller (crtc=31) already present. [1402:1419:1017/132558.840237:VERBOSE1:drm_display.cc(104)] DRM configuring: device=/sys/devices/pci0000:00/0000:00:02.0/drm/card0 crtc=31 connector=47 origin=0,0 size=1366x768 [1182:1182:1017/132609.483810:VERBOSE1:gaia_screen_handler.cc(596)] OnPortalDetectionCompleted Online [1402:1419:1017/132610.929426:WARNING:screen_manager.cc(114)] Display controller (crtc=31) already present. [1402:1419:1017/132610.931196:VERBOSE1:drm_display.cc(104)] DRM configuring: device=/sys/devices/pci0000:00/0000:00:02.0/drm/card0 crtc=31 connector=47 origin=0,0 size=0x0 [1402:1419:1017/132622.349303:WARNING:screen_manager.cc(114)] Display controller (crtc=31) already present. [1402:1419:1017/132622.354041:VERBOSE1:drm_display.cc(104)] DRM configuring: device=/sys/devices/pci0000:00/0000:00:02.0/drm/card0 crtc=31 connector=47 origin=0,0 size=1366x768 [1182:1182:1017/132639.667778:INFO:status_uploader.cc(219)] Starting status upload: have_device_status = 1 [1182:1182:1017/132640.012503:INFO:status_uploader.cc(232)] Status upload successful [1182:1182:1017/132641.993761:VERBOSE1:signin_screen_handler.cc(597)] OnNetworkReady() call. [1182:1182:1017/132641.993842:VERBOSE1:gaia_screen_handler.cc(314)] MaybePreloadAuthExtension [1182:1182:1017/132642.093614:VERBOSE1:gaia_screen_handler.cc(596)] OnPortalDetectionCompleted Online [1182:1182:1017/132642.999712:INFO:remote_commands_invalidator.cc(45)] Shutdown RemoteCommandsInvalidator. [1182:1182:1017/132643.000320:INFO:remote_commands_invalidator.cc(68)] Stopping RemoteCommandsInvalidator. [1182:1182:1017/132643.000708:INFO:remote_commands_invalidator.cc(167)] Unregister RemoteCommandsInvalidator. [1182:1182:1017/132652.910232:INFO:remote_commands_invalidator.cc(32)] Initialize RemoteCommandsInvalidator. [1182:1182:1017/132652.910510:INFO:remote_commands_invalidator.cc(57)] Starting RemoteCommandsInvalidator. [1182:1182:1017/132652.910631:INFO:remote_commands_invalidator.cc(123)] RemoteCommandsInvalidator ReloadPolicyData. [1182:1182:1017/132652.910782:INFO:remote_commands_invalidator.cc(147)] Register RemoteCommandsInvalidator. [1182:1182:1017/132652.910886:INFO:remote_commands_invalidator.cc(83)] RemoteCommandsInvalidator state changed: 3 [1182:1182:1017/132652.911112:INFO:remote_commands_invalidator.cc(83)] RemoteCommandsInvalidator state changed: 3 [1182:1182:1017/132654.155013:INFO:remote_commands_invalidator.cc(94)] RemoteCommandsInvalidator received invalidation. [1182:1182:1017/132654.155247:INFO:remote_commands_invalidator.cc(110)] Invalidations acknowledged. [1182:1182:1017/132654.155317:INFO:remote_commands_service.cc(38)] Fetching remote commands. [1182:1182:1017/132654.488193:INFO:remote_commands_service.cc(165)] Remote commands fetched.
,
Oct 17
DMServer sent an error response: 902 mapps to policy not found Show error, error_id: 2273, attempts:1, help_topic_id: 188036 |
||
►
Sign in to add a comment |
||
Comment 1 by r...@chromium.org
, Oct 5Owner: agawronska@chromium.org
Status: Assigned (was: Untriaged)