"Shutdown now" hangs

So we have a problem with $ sudo shutdown now hanging on the line systemd-shutdown[1]: Detaching DM devices every time we try to turn off or reboot the device. This is the output we get over the UART debug at shutdown:

[15:00:34:097] logout␍␊
[15:00:34:293] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mUser Manager for UID 0<0x1b>[0m.␍␍␊
[15:00:34:293] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mSession 4 of user guard<0x1b>[0m.␍␍␊
[15:00:34:293]          Stopping <0x1b>[0;1;39mLogin Service<0x1b>[0m...␍␍␊
[15:00:34:293]          Stopping <0x1b>[0;1;39mUser Manager for UID 1000<0x1b>[0m...␍␍␊
[15:00:34:293]          Stopping <0x1b>[0;1;39mUser Runtime Directory /run/user/0<0x1b>[0m...␍␍␊
[15:00:34:293]          Stopping <0x1b>[0;1;39mLSB: set CPUFreq kernel parameters<0x1b>[0m...␍␍␊
[15:00:34:293] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mSystem Time Synchronized<0x1b>[0m.␍␍␊
[15:00:34:293] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mNetwork is Online<0x1b>[0m.␍␍␊
[15:00:34:336] [<0x1b>[0;32m  OK  <0x1b>[0m] Unmounted <0x1b>[0;1;39m/run/user/0<0x1b>[0m.␍␍␊
[15:00:34:336] [<0x1b>[0;32m  OK  <0x1b>[0m] Started <0x1b>[0;1;39mShow Plymouth Power Off Screen<0x1b>[0m.␍␍␊
[15:00:34:336] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mUser Runtime Directory /run/user/0<0x1b>[0m.␍␍␊
[15:00:34:336] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mUser Manager for UID 1000<0x1b>[0m.␍␍␊
[15:00:34:336]          Stopping <0x1b>[0;1;39mUser Runtime Directory /run/user/1000<0x1b>[0m...␍␍␊
[15:00:34:336] [<0x1b>[0;32m  OK  <0x1b>[0m] Removed slice <0x1b>[0;1;39mUser Slice of UID 0<0x1b>[0m.␍␍␊
[15:00:34:336] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mLSB: set CPUFreq kernel parameters<0x1b>[0m.␍␍␊
[15:00:34:379] [<0x1b>[0;32m  OK  <0x1b>[0m] Unmounted <0x1b>[0;1;39m/run/user/1000<0x1b>[0m.␍␍␊
[15:00:34:379] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mLogin Service<0x1b>[0m.␍␍␊
[15:00:34:379] [<0x1b>[0;32m  OK  <0x1b>[0m] Reached target <0x1b>[0;1;39mUnmount All Filesystems<0x1b>[0m.␍␍␊
[15:00:34:379]          Stopping <0x1b>[0;1;39mLSB: Load kernel <0xe2><0x80><0xa6>d to enable cpufreq scaling<0x1b>[0m...␍␍␊
[15:00:34:379] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mUser Runtime Directory /run/user/1000<0x1b>[0m.␍␍␊
[15:00:34:379] [<0x1b>[0;32m  OK  <0x1b>[0m] Removed slice <0x1b>[0;1;39mUser Slice of UID 1000<0x1b>[0m.␍␍␊
[15:00:34:379]          Stopping <0x1b>[0;1;39mPermit User Sessions<0x1b>[0m...␍␍␊
[15:00:34:442] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mPermit User Sessions<0x1b>[0m.␍␍␊
[15:00:34:442] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mLSB: Load kernel m<0xe2><0x80><0xa6>ded to enable cpufreq scaling<0x1b>[0m.␍␍␊
[15:00:34:442] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mRemote File Systems<0x1b>[0m.␍␍␊
[15:00:34:442] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mNetwork<0x1b>[0m.␍␍␊
[15:00:34:442]          Stopping <0x1b>[0;1;39mRaise network interfaces<0x1b>[0m...␍␍␊
[15:00:34:442]          Stopping <0x1b>[0;1;39mifup for wlp1s0<0x1b>[0m...␍␍␊
[15:00:34:442]          Stopping <0x1b>[0;1;39mNetwork Manager<0x1b>[0m...␍␍␊
[15:00:34:442]          Stopping <0x1b>[0;1;39mWPA supplicant<0x1b>[0m...␍␍␊
[15:00:34:463] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mWPA supplicant<0x1b>[0m.␍␍␊
[15:00:34:542] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mRaise network interfaces<0x1b>[0m.␍␍␊
[15:00:34:542] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mNetwork Manager<0x1b>[0m.␍␍␊
[15:00:34:542]          Stopping <0x1b>[0;1;39mD-Bus System Message Bus<0x1b>[0m...␍␍␊
[15:00:34:542] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mD-Bus System Message Bus<0x1b>[0m.␍␍␊
[15:00:34:542] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mBasic System<0x1b>[0m.␍␍␊
[15:00:34:542] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mForward Password R<0xe2><0x80><0xa6>s to Plymouth Directory Watch<0x1b>[0m.␍␍␊
[15:00:34:542] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mSockets<0x1b>[0m.␍␍␊
[15:00:34:542] [<0x1b>[0;32m  OK  <0x1b>[0m] Closed <0x1b>[0;1;39mSyslog Socket<0x1b>[0m.␍␍␊
[15:00:34:585] [<0x1b>[0;32m  OK  <0x1b>[0m] Closed <0x1b>[0;1;39mGPS (Global Positioning System) Daemon Sockets<0x1b>[0m.␍␍␊
[15:00:34:585] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mSlices<0x1b>[0m.␍␍␊
[15:00:34:585] [<0x1b>[0;32m  OK  <0x1b>[0m] Removed slice <0x1b>[0;1;39mUser and Session Slice<0x1b>[0m.␍␍␊
[15:00:34:585] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mPaths<0x1b>[0m.␍␍␊
[15:00:34:585] [<0x1b>[0;32m  OK  <0x1b>[0m] Closed <0x1b>[0;1;39mD-Bus System Message Bus Socket<0x1b>[0m.␍␍␊
[15:00:34:585] [<0x1b>[0;32[  593.265576] wlp1s0: deauthenticating from cc:2d:e0:e7:42:4b by local choice (Reason: 3=DEAUTH_LEAVING)␍␊
[15:00:34:628] m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mSystem Initialization<0x1b>[0m.␍␍␊
[15:00:34:628]          Stopping <0x1b>[0;1;39mNetwork Time Synchronization<0x1b>[0m...␍␍␊
[15:00:34:628] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mLocal Encrypted Volumes<0x1b>[0m.␍␍␊
[15:00:34:628] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mForward Password R<0xe2><0x80><0xa6>uests to Wall Directory Watch<0x1b>[0m.␍␍␊
[15:00:34:628] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mSwap<0x1b>[0m.␍␍␊
[15:00:34:628]          Stopping <0x1b>[0;1;39mUpdate UTMP about System Boot/Shutdown<0x1b>[0m...␍␍␊
[15:00:34:628]          Stopping <0x1b>[0;1;39mLoad/Save Random Seed<0x1b>[0m...␍␍␊
[15:00:34:665] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mNetwork Time Synchronization<0x1b>[0m.␍␍␊
[15:00:34:665] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mLoad/Save Random Seed<0x1b>[0m.␍␍␊
[15:00:34:665] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mUpdate UTMP about System Boot/Shutdown<0x1b>[0m.␍␍␊
[15:00:34:665] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mCreate Volatile Files and Directories<0x1b>[0m.␍␍␊
[15:00:34:825] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mifup for wlp1s0<0x1b>[0m.␍␍␊
[15:00:34:868] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mLocal File Systems<0x1b>[0m.␍␍␊
[15:00:34:868] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target <0x1b>[0;1;39mLocal File Systems (Pre)<0x1b>[0m.␍␍␊
[15:00:34:868] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mCreate Static Device Nodes in /dev<0x1b>[0m.␍␍␊
[15:00:34:868] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mCreate System Users<0x1b>[0m.␍␍␊
[15:00:34:868] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mRemount Root and Kernel File Systems<0x1b>[0m.␍␍␊
[15:00:34:868] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mApply Kernel Variables<0x1b>[0m.␍␍␊
[15:00:34:868] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped <0x1b>[0;1;39mLoad Kernel Modules<0x1b>[0m.␍␍␊
[15:00:34:905] [<0x1b>[0;32m  OK  <0x1b>[0m] Reached target <0x1b>[0;1;39mShutdown<0x1b>[0m.␍␍␊
[15:00:34:905] [<0x1b>[0;32m  OK  <0x1b>[0m] Reached target <0x1b>[0;1;39mFinal Step<0x1b>[0m.␍␍␊
[15:00:34:905] [<0x1b>[0;32m  OK  <0x1b>[0m] Started <0x1b>[0;1;39mPower-Off<0x1b>[0m.␍␍␊
[15:00:34:905] [<0x1b>[0;32m  OK  <0x1b>[0m] Reached target <0x1b>[0;1;39mPower-Off<0x1b>[0m.␍␍␊
[15:00:34:965] [  593.639395] systemd-shutdow: 30 output lines suppressed due to ratelimiting␍␊
[15:00:35:006] [  593.680082] systemd-shutdown[1]: Syncing filesystems and block devices.␍␊
[15:00:35:034] [  593.703054] systemd-shutdown[1]: Sending SIGTERM to remaining processes...␍␊
[15:00:35:034] [  593.708312] systemd-journald[1941]: Received SIGTERM from PID 1 (systemd-shutdow).␍␊
[15:00:35:087] [  593.748891] systemd-shutdown[1]: Sending SIGKILL to remaining processes...␍␊
[15:00:35:087] [  593.757580] systemd-shutdown[1]: Unmounting file systems.␍␊
[15:00:35:087] [  593.763034] [2731]: Remounting '/' read-only in with options 'data=ordered'.␍␊
[15:00:35:127] [  593.800996] EXT4-fs (sda10): re-mounted. Opts: data=ordered␍␊
[15:00:35:127] [  593.820361] systemd-shutdown[1]: All filesystems unmounted.␍␊
[15:00:35:172] [  593.820454] systemd-shutdown[1]: Deactivating swaps.␍␊
[15:00:35:172] [  593.825390] systemd-shutdown[1]: All swaps deactivated.␍␊
[15:00:35:172] [  593.830081] systemd-shutdown[1]: Detaching loop devices.␍␊
[15:00:35:172] [  593.844133] systemd-shutdown[1]: All loop devices detached.␍␊
[15:00:35:172] [  593.844174] systemd-shutdown[1]: Detaching DM devices.␍␊

This might have to do something with the fact that we created a custom rootfs image from the generated one with chroot following this guide. This doesn’t happen on the original image.
$ sudo poweroff -f also hangs even if we wait a few minutes.

Might not be related, but it also fails to start the Qualcomm remotefs service at boot:

● rmtfs.service - Qualcomm remotefs service
   Loaded: loaded (/lib/systemd/system/rmtfs.service; enabled; vendor preset: enabled)
   Active: failed (Result: exit-code) since Tue 2021-05-25 15:38:08 CEST; 5min ago
  Process: 2597 ExecStart=/usr/bin/rmtfs -r -P -s (code=exited, status=1/FAILURE)
 Main PID: 2597 (code=exited, status=1/FAILURE)

May 25 15:38:08 user systemd[1]: rmtfs.service: Service RestartSec=1s expired, scheduling restart.
May 25 15:38:08 user systemd[1]: rmtfs.service: Scheduled restart job, restart counter is at 5.
May 25 15:38:08 user systemd[1]: Stopped Qualcomm remotefs service.
May 25 15:38:08 user systemd[1]: rmtfs.service: Start request repeated too quickly.
May 25 15:38:08 user systemd[1]: rmtfs.service: Failed with result 'exit-code'.
May 25 15:38:08 user systemd[1]: Failed to start Qualcomm remotefs service.

Any suggestions?

Have you tried to disable this service?

systemctl disable rmtfs

Just to confirm if it’s related, or not…

We disabled it now, but the same hang still occurs on shutdown. Any idea how to get more logs on what is happening, systemd-shutdown[1]: Detaching DM devices might be a red herring…

Debug output for $ sudo shutdown now on a freshly built image looks completly different

[13:40:05:834] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Sound Card.␍␊
[13:40:05:834]          Stopping Session 6 of user linaro.␍␊
[13:40:05:834] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Graphical Interface.␍␊
[13:40:05:834]          Stopping Disk Manager...␍␊
[13:40:05:834] [<0x1b>[0;32m  OK  <0x1b>[0m] Closed Load/Save         Stopping User Manager for UID 1000...␍␊
[13:40:05:834]          Stopping RMTFS setup...␍␊
[13:40:05:878]          Stopping Session 8 of user linaro.␍␊
[13:40:05:878]          Stopping Authorization Manager...␍␊
[13:40:05:878]          Stopping Modem Manager...␍␊
[13:40:05:878]          Stopping Session 3 of user linaro.␍␊
[13:40:05:910] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Login Prompts.␍␊
[13:40:05:954]          Stopping Serial Getty on ttyMSM0...␍␊
[13:40:05:954]          Stopping Getty on tty1...␍␊
[13:40:05:954] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Daily Cleanup of Temporary Directories.␍␊
[13:40:05:954]          Stopping System Logging Service...␍␊
[13:40:05:970]          Stopping LSB: sets blue led blink frequency...␍␊
[13:40:05:986] [ 9732.647641] >>>>>>> osd_panel_prepare <<<<<<<␍␊
[13:40:06:007]          Stopping Simple Desktop Display Manager...␍␊
[13:40:06:007] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Daily apt download activities.␍␊
[13:40:06:023] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Daily rotation of log files.␍␊
[13:40:06:055] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target System Time Synchronized.␍␊
[13:40:06:055]          Stopping OpenBSD Secure Shell server...␍␊
[13:40:06:071] [ 9732.724541] >>>>>>> osd_panel_push_cmd_list <<<<<<<␍␊
[13:40:06:087] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Bluetooth.␍␊
[13:40:06:117]          Stopping Bluetooth service...␍␊
[13:40:06:117]          Stopping Daemon for power management...␍␊
[13:40:06:148]          Stopping LSB: set CPUFreq kernel parameters...␍␊
[13:40:06:148]          Stopping Session 9 of user linaro.␍␊
[13:40:06:164] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Modem Manager.␍␊
[13:40:06:180] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped System Logging Service.␍␊
[13:40:06:212] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Disk Manager.␍␊
[13:40:06:237] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Regular background program processing daemon.␍␊
[13:40:06:237] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Authorization Manager.␍␊
[13:40:06:269] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Bluetooth service.␍␊
[13:40:06:284] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped RMTFS setup.␍␊
[13:40:06:300] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped OpenBSD Secure Shell server.␍␊
[13:40:06:317] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Getty on tty1.␍␊
[13:40:06:349] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Serial Getty on ttyMSM0.␍␊
[13:40:06:364] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped User Manager for UID 0.␍␊
[13:40:06:396] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped User Manager for UID 1000.␍␊
[13:40:06:428] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Daemon for power management.␍␊
[13:40:06:466] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped LSB: sets blue led blink frequency.␍␊
[13:40:06:466] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Session 1 of user root.␍␊
[13:40:06:482] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Session 6 of user linaro.␍␊
[13:40:06:514]          Stopping /run/user/1000 mount wrapper...␍␊
[13:40:06:544] [<0x1b>[0;32m  OK  <0x1b>[0m] Removed slice User Slice of UID 0.␍␊
[13:40:06:560]          Stopping /run/user/0 mount wrapper...␍␊
[13:40:06:581] [<0x1b>[0;32m  OK  <0x1b>[0m] Removed slice system-serial\x2dgetty.slice.␍␊
[13:40:06:581] [<0x1b>[0;32m  OK  <0x1b>[0m] Removed slice system-getty.slice.␍␊
[13:40:06:612] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped /etc/rc.local Compatibility.␍␊
[13:40:06:628]          Stopping QRTR service...␍␊
[13:40:06:644] [<0x1b>[0;32m  OK  <0x1b>[0m] Unmounted /run/user/1000.␍␊
[13:40:06:672] [<0x1b>[0;32m  OK  <0x1b>[0m] Unmounted /run/user/0.␍␊
[13:40:06:700] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped LSB: set CPUFreq kernel parameters.␍␊
[13:40:06:716] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped /run/user/1000 mount wrapper.␍␊
[13:40:06:732] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped /run/user/0 mount wrapper.␍␊
[13:40:06:764] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped QRTR service.␍␊
[13:40:06:780] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Session 9 of user linaro.␍␊
[13:40:06:796] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Session 8 of user linaro.␍␊
[13:40:06:826] [<0x1b>[0;32m  OK  <0x1b>[0m] Removed slice system-user\x2druntime\x2ddir.slice.␍␊
[13:40:06:849]          Stopping LSB: Load kernel modules needed to enable cpufreq scaling...␍␊
[13:40:06:897] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped LSB: Load kernel modules needed to enable cpufreq scaling.␍␊
[13:40:08:324] [ 9734.979486] >>>>>>> osd_panel_enable <<<<<<<␍␊
[13:40:08:369] [ 9735.013050] >>>>>>> osd_panel_disable <<<<<<<␍␊
[13:40:08:369] [ 9735.013087] >>>>>>> osd_panel_unprepare <<<<<<<␍␊
[13:40:10:926] [ 9735.237808] >>>>>>> osd_panel_prepare <<<<<<<␍␊
[13:40:10:957] [ 9735.308596] >>>>>>> osd_panel_push_cmd_list <<<<<<<␍␊
[13:40:10:957] [ 9737.547482] >>>>>>> osd_panel_enable <<<<<<<␍␊
[13:40:10:957] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Session 3 of user linaro.␍␊
[13:40:10:957] [<0x1b>[0;32m  OK  <0x1b>[0m] Removed slice User Slice of UID 1000.␍␊
[13:40:11:186] [ 9737.830017] >>>>>>> osd_panel_get_modes <<<<<<<␍␊
[13:40:11:186] [ 9737.831339] >>>>>>> osd_panel_get_modes <<<<<<<␍␊
[13:40:11:705] [ 9738.349619] >>>>>>> osd_panel_disable <<<<<<<␍␊
[13:40:11:705] [ 9738.349658] >>>>>>> osd_panel_unprepare <<<<<<<␍␊
[13:40:14:292] [ 9738.575506] >>>>>>> osd_panel_prepare <<<<<<<␍␊
[13:40:14:292] [ 9738.648599] >>>>>>> osd_panel_push_cmd_list <<<<<<<␍␊
[13:40:14:292] [ 9740.887505] >>>>>>> osd_panel_enable <<<<<<<␍␊
[13:40:14:356] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Simple Desktop Display Manager.␍␊
[13:40:14:373]          Stopping Login Service...␍␊
[13:40:14:388]          Stopping Permit User Sessions...␍␊
[13:40:14:404] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Permit User Sessions.␍␊
[13:40:14:436] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Network.␍␊
[13:40:14:452]          Stopping Raise network interfaces...␍␊
[13:40:14:467]          Stopping ifup for wlp1s0...␍␊
[13:40:14:496]          Stopping Network Manager...␍␊
[13:40:14:496]          Stopping WPA supplicant...␍␊
[13:40:14:512] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Remote File Systems.␍␊
[13:40:14:528] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Login Service.␍␊
[13:40:14:544] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Network Manager.␍␊
[13:40:14:576] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped WPA supplicant.␍␊
[13:40:14:592]          Stopping D-Bus System Message Bus...␍␊
[13:40:14:637] [ 9741.265813] wlp1s0: deauthenticating from cc:2d:e0:e7:42:4b by local choice (Reason: 3=DEAUTH_LEAVING)␍␊
[13:40:14:637] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped D-Bus System Message Bus.␍␊
[13:40:14:637] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Basic System.␍␊
[13:40:14:637] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Paths.␍␊
[13:40:14:681] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Slices.␍␊
[13:40:14:681] [<0x1b>[0;32m  OK  <0x1b>[0m] Removed slice User and Session Slice.␍␊
[13:40:14:681] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Sockets.␍␊
[13:40:14:708] [<0x1b>[0;32m  OK  <0x1b>[0m] Closed GPS (Global Positioning System) Daemon Sockets.␍␊
[13:40:14:708] [<0x1b>[0;32m  OK  <0x1b>[0m] Closed Syslog Socket.␍␊
[13:40:14:724] [<0x1b>[0;32m  OK  <0x1b>[0m] Closed D-Bus System Message Bus Socket.␍␊
[13:40:14:740] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target System Initialization.␍␊
[13:40:14:756]          Stopping Load/Save Random Seed...␍␊
[13:40:14:772] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Swap.␍␊
[13:40:14:788] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Local Encrypted Volumes.␍␊
[13:40:14:813] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Dispatch Password Requests to Console Directory Watch.␍␊
[13:40:14:836] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Forward Password Requests to Wall Directory Watch.␍␊
[13:40:14:836]          Stopping Update UTMP about System Boot/Shutdown...␍␊
[13:40:14:867]          Stopping Network Time Synchronization...␍␊
[13:40:14:883] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Raise network interfaces.␍␊
[13:40:14:899] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Network Time Synchronization.␍␊
[13:40:14:931] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped ifup for wlp1s0.␍␊
[13:40:14:947] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Load/Save Random Seed.␍␊
[13:40:14:963] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Apply Kernel Variables.␍␊
[13:40:14:993] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Load Kernel Modules.␍␊
[13:40:15:019] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Update UTMP about System Boot/Shutdown.␍␊
[13:40:15:048] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Create Volatile Files and Directories.␍␊
[13:40:15:048] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Local File Systems.␍␊
[13:40:15:079]          Unmounting /media/linaro/stasusb...␍␊
[13:40:15:111] [<0x1b>[0;32m  OK  <0x1b>[0m] Unmounted /media/linaro/stasusb.␍␊
[13:40:15:140] [<0x1b>[0;32m  OK  <0x1b>[0m] Reached target Unmount All Filesystems.␍␊
[13:40:15:179]          Stopping Clean the /media/linaro/stasusb mount point...␍␊
[13:40:15:179] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped target Local File Systems (Pre).␍␊
[13:40:15:200] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Create Static Device Nodes in /dev.␍␊
[13:40:15:200] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Create System Users.␍␊
[13:40:15:228] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Remount Root and Kernel File Systems.␍␊
[13:40:15:228] [<0x1b>[0;32m  OK  <0x1b>[0m] Stopped Clean the /media/linaro/stasusb mount point.␍␊
[13:40:15:268] [<0x1b>[0;32m  OK  <0x1b>[0m] Removed slice system-clean\x2dmount\x2dpoint.slice.␍␊
[13:40:15:268] [<0x1b>[0;32m  OK  <0x1b>[0m] Reached target Shutdown.␍␊
[13:40:15:284] [<0x1b>[0;32m  OK  <0x1b>[0m] Reached target Final Step.␍␊
[13:40:15:300]          Starting Power-Off...␍␊
[13:40:15:455] [ 9742.098323] systemd-journald[1924]: Received SIGTERM from PID 1 (systemd-shutdow).␍␊
[13:40:15:527] [ 9742.169547] EXT4-fs (sda10): re-mounted. Opts: data=ordered␍␊
[13:40:15:607] [ 9742.227306] >>>>>>> osd_panel_shutdown <<<<<<<␍␊
[13:40:15:607] [ 9742.227326] >>>>>>> osd_panel_disable <<<<<<<␍␊
[13:40:15:607] [ 9742.230882] arm-smmu b40000.arm,smmu: removing device with active domains!␍␊
[13:40:15:607] [ 9742.235652] sd 0:0:0:5: [sdf] Synchronizing SCSI cache␍␊
[13:40:15:607] [ 9742.242123] sd 0:0:0:4: [sde] Synchronizing SCSI cache␍␊
[13:40:15:607] [ 9742.247519] sd 0:0:0:3: [sdd] Synchronizing SCSI cache␍␊
[13:40:15:607] [ 9742.252415] sd 0:0:0:2: [sdc] Synchronizing SCSI cache␍␊
[13:40:15:607] [ 9742.257284] sd 0:0:0:1: [sdb] Synchronizing SCSI cache␍␊
[13:40:15:607] [ 9742.262420] sd 0:0:0:0: [sda] Synchronizing SCSI cache␍␊
[13:40:15:656] [ 9742.276179] arm-smmu d40000.arm,smmu-venus: removing device with active domains!␍␊
[13:40:15:656] [ 9742.276280] arm-smmu 1600000.arm,smmu-lpass_q6: removing device with active domains!␍␊
[13:40:15:656] [ 9742.282734] arm-smmu d00000.arm,smmu: removing device with active domains!␍␊
[13:40:15:656] [ 9742.290554] arm-smmu da0000.arm,smmu: removing device with active domains!␍␊
[13:40:15:656] [ 9742.303552] usb 2-1.1: USB disconnect, device number 3␍␊
[13:40:15:673] [ 9742.335193] reboot: Power down␍␊
[13:40:15:683] <break>

I think we solved the issue. We were flashing the wrong version of emmc_appsboot.mbn from an older BSP.

1 Like