[Solved / Archived] Wiity Pi 4 – RPi reboots after scheduled shutdown. Scheduled startup doesn't happen

I couldn't recreate the problem so far, but I have the feeling things like this happen quite some time 🙁

The log said Witty Pi's software was waiting for shutdown ("Pending for incoming shutdown command..."), but there was no record of actual shutdown.

How did you know the device shutdown and immediately reboot? If you saw it reboot, why did you say the "LED didn't pulse, but the raspberrypi is off"?

After many successful scheduled boots and reboots it just occured again.

And this time I got the log I mentioned from the manual in the first post!

Apr 21 15:19:54 raspberrypi wittypi[338]: Maybe the scheduled startup was due when Pi was running, or Pi had been shut down but TXD stayed HIGH to prevent the power cut.

One more information:
In the described state, after missed scheduled boot, where wittyPi LED doesn't pulse, but also RPi is off, clicking the power button does not help. Only unpluging power to wittypi or pressing power button for 10 seconds make the raspberrypi turn on again.

Altough it says

Apr 21 15:19:54 raspberrypi wittypi[338]: System starts up because of the scheduled startup got delayed.

Posted by: @admin

↑

The log said Witty Pi's software was waiting for shutdown ("Pending for incoming shutdown command..."), but there was no record of actual shutdown.

The shutdown isn't the problem I think?

Posted by: @admin

↑

How did you know the device shutdown and immediately reboot?

That's what the logs say from:

-- Boot a98a7e23993d4a08aa4d298db6bee585 --
Apr 20 07:05:16 raspberrypi kernel: Booting Linux on physical CPU 0x0

Posted by: @admin

↑

If you saw it reboot, why did you say the "LED didn't pulse, but the raspberrypi is off"?

I didn't see it. The described state (that reoccured now) is what I saw when I checked the device.

From the new case, with the log message, does it mean, the shutdown was not finished, and so it didn't cut power?

Or is it our LTE-Stick that takes too much power from the RPi?

The power cut delay is currently set to 25.0s

Posted by: @mmoollllee

↑

The shutdown isn't the problem I think?

It might be related. A well configured device should have correct log information for such kind of events. If it doesn't, that means something goes wrong.

It will be very difficult to guess what actually happened without seeing it. My suggestion is to schedule the shutdown and startup with much shorter peroid, so you can observe how it behaves in person.

Just happend again. I was not around again. Logs just indicate, that shutdown took a little longer because of a shutdown log to the server. LTE Dongle was removed before.

19:30:00 Shutdown as scheduled
19:30:15 Shutdown done, but RPi reboots directly!?
19:31:02 Power cut (last log entry from journalctl)
19:35:00 Scheduled Startup never happend

Log messages this time:

System starts up because of the scheduled startup got delayed.
Maybe the scheduled startup was due when Pi was running, or Pi had been shut down but TXD stayed HIGH to prevent the power cut.

Why does the RPi even reboot?

@mmoollllee The log said the possible reasons. You will need to observe it to confirm what actually happened.

But I don't understand the reasons, I'm sorry!

What I don't understand in detail:

• why does the raspberrypi reboot after scheduled shutdown? From my understanding shutdown should be something like `sudo shutdown now`, but with wittypi shutdown it's more like `sudo reboot`?
• after the RPi reboots after the scheduled shutdown, from my understanding power get's cut anyway -> RPi is off. But why does scheduled startup not work afterwards?

Can you help me understand what is going on?

@mmoollllee for example, you scheduled startup at 14:00 but you did not shutdown your Pi until 14:20. The scheulded startup was due at 14:00 but your Pi was ON at that moment, instead of directly ignoring this event, Witty Pi's firmware postponded it until your Pi eventually turned OFF. So it looked like a reboot.

Back to your case, you need to figure out why a startup was scheduled at a moment that your Pi is still ON (which is not normal). Usually you can figure out from the wittyPi.log file.

BTW, this behavior is called "ALARM1 delay", and it can be turned off by setting bit 0 in I2C register I2C_CONF_MISC (#48) to 1. However simply turning off this behavor usually do not solve the problem: a well-configured device usually would not trigger such behavior at the first place.

Posted by: @admin

↑

@mmoollllee for example, you scheduled startup at 14:00 but you did not shutdown your Pi until 14:20. The scheulded startup was due at 14:00 but your Pi was ON at that moment, instead of directly ignoring this event, Witty Pi's firmware postponded it until your Pi eventually turned OFF. So it looked like a reboot.

I don't know if this is related to my case, as the problem seems to occour through the scheduled shutdown that does result in power cut by wittypi!

Posted by: @admin

↑

Back to your case, you need to figure out why a startup was scheduled at a moment that your Pi is still ON (which is not normal). Usually you can figure out from the wittyPi.log file.

That's not the case! Startup happens in a moment where RPi has no power. It's not starting!

Posted by: @admin

↑

BTW, this behavior is called "ALARM1 delay", and it can be turned off by setting bit 0 in I2C register I2C_CONF_MISC (#48) to 1. However simply turning off this behavor usually do not solve the problem: a well-configured device usually would not trigger such behavior at the first place.

I guess I'll just try this setting and see what happens?

@mmoollllee well, you said you don't understand why it looks like a reboot, instead of shutdown and power cut. I gave you the explaination, then you say "no, it is not the case!"

You previously asked "Why does the RPi even reboot?", and later said "Startup happens in a moment where RPi has no power. It's not starting!". Don't you see they are contradictory?

If you can't even describe the question correctly, nobody can help you.

I guess we're talking about different things, and I have the feeling you're pretending the RPi is turned on when startup schedule happens. But that's not the case. Please have a look at my previous post.

From 19:31:02 the RPi is off!
The unexpected reboot at 19:30:15 could just be an indicator for the reason, that scheduled startup at 19:35:00 does not occour.

Posted by: @mmoollllee

↑

19:30:00 Shutdown as scheduled
19:30:15 Shutdown done, but RPi reboots directly!?
19:31:02 Power cut (last log entry from journalctl)
19:35:00 Scheduled Startup never happend

There was no reboot at all. You think there was a reboot because of this log line:

Apr 20 07:05:16 raspberrypi kernel: Booting Linux on physical CPU 0x0

But the timestamp in this line is wrong, because Raspberry Pi itself doesn't have RTC and its system time is wrong until Witty Pi's software wrote the RTC time into the system. See these two lines in your log:

Apr 20 07:05:55 raspberrypi sudo[513]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 20 09:56:17 raspberrypi sudo[513]: pam_unix(sudo:session): session closed for user root

The reason that the time changed for 2+ hours here, was because Witty Pi's software wrote the correct time into the system. The whole startup session started at about 9:56, not 7:05. The correct way to read timestamp in log has been mentioned on page 35 in the user manual, the same thing applies to system log too.

Your scheduled startup didn't happen because of something else. I prevously suggested you to check why shutdown event was not recorded in log, I also suggested you to schedule the shutdown and startup with much shorter peroid, so you can observe how it behaves in person. But you didn't take my suggestions, did you?

Posted by: @admin

↑

There was no reboot at all. You think there was a reboot because of this log line:

Apr 20 07:05:16 raspberrypi kernel: Booting Linux on physical CPU 0x0

But the timestamp in this line is wrong, because Raspberry Pi itself doesn't have RTC and its system time is wrong until Witty Pi's software wrote the RTC time into the system. See these two lines in your log:

Apr 20 07:05:55 raspberrypi sudo[513]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 20 09:56:17 raspberrypi sudo[513]: pam_unix(sudo:session): session closed for user root

The reason that the time changed for 2+ hours here, was because Witty Pi's software wrote the correct time into the system. The whole startup session started at about 9:56, not 7:05. The correct way to read timestamp in log has been mentioned on page 35 in the user manual, the same thing applies to system log too.

Aaaaalllriggghttt!! Now I see... I'm sorry for not understanding this before 🙁

Posted by: @admin

↑

I prevously suggested you to check why shutdown event was not recorded in log

Hmm from the last time it happend shutdown was recorded.. See the full log to when we manually booted again:

-- Journal begins at Sat 2024-04-20 12:00:57 CEST, ends at Tue 2024-04-23 08:50:02 CEST. --
Apr 23 19:29:00 raspberrypi /home/admin/Desktop/pipipi/app.py[1075]: doing stuff
Apr 23 19:29:52 raspberrypi wittypi[347]: Shutting down system because scheduled shutdown is due.
Apr 23 19:29:52 raspberrypi /home/admin/Desktop/pipipi/app.py[1075]: helpers.system_info()
Apr 23 19:29:53 raspberrypi /home/admin/Desktop/pipipi/app.py[1075]: helpers.read_voltage()
Apr 23 19:29:54 raspberrypi /home/admin/Desktop/pipipi/app.py[1075]: WittyPi Voltage: 11.84 Volt
Apr 23 19:29:54 raspberrypi wittypi[347]: Halting all processes and then shutdown Raspberry Pi...
Apr 23 19:29:54 raspberrypi /home/admin/Desktop/pipipi/app.py[1075]: Next Witty Startup: 22 19:40:00
Apr 23 19:29:54 raspberrypi /home/admin/Desktop/pipipi/app.py[1075]: Exiting.
Apr 22 19:30:00 raspberrypi systemd[1]: Stopping Session 2 of user admin.
Apr 22 19:30:00 raspberrypi systemd[1]: Stopping Session 4 of user admin.
Apr 22 19:30:01 raspberrypi systemd[1]: Removed slice system-modprobe.slice.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped target Bluetooth.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped target Graphical Interface.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped target Multi-User System.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped target Login Prompts.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped target Sound Card.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped target Timers.
Apr 22 19:30:01 raspberrypi systemd[1]: apt-daily-upgrade.timer: Succeeded.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped Daily apt upgrade and clean activities.
Apr 22 19:30:01 raspberrypi systemd[1]: apt-daily.timer: Succeeded.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped Daily apt download activities.
Apr 22 19:30:01 raspberrypi systemd[1]: e2scrub_all.timer: Succeeded.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped Periodic ext4 Online Metadata Check for All Filesystems.
Apr 22 19:30:01 raspberrypi systemd[1]: fstrim.timer: Succeeded.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped Discard unused blocks once a week.
Apr 22 19:30:01 raspberrypi systemd[1]: logrotate.timer: Succeeded.
Apr 22 19:30:01 raspberrypi lightdm[705]: pam_unix(lightdm-autologin:session): session closed for user admin
Apr 22 19:30:01 raspberrypi polkitd(authority=local)[267]: Unregistered Authentication Agent for unix-session:4 (system bus name :1.39, object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale en_GB.UTF-8) (disconnected from bus)
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped Daily rotation of log files.
Apr 22 19:30:01 raspberrypi systemd[1]: man-db.timer: Succeeded.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped Daily man-db regeneration.
Apr 22 19:30:01 raspberrypi systemd[1]: systemd-tmpfiles-clean.timer: Succeeded.
Apr 22 19:30:01 raspberrypi systemd[1]: Stopped Daily Cleanup of Temporary Directories.
Apr 22 19:30:01 raspberrypi systemd[1]: systemd-rfkill.socket: Succeeded.
Apr 22 19:30:01 raspberrypi systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
Apr 22 19:30:01 raspberrypi systemd[1]: Unmounting RPC Pipe File System...
Apr 22 19:30:01 raspberrypi systemd[1]: Stopping Modem Manager...
Apr 22 19:30:02 raspberrypi ModemManager[387]: <info>  caught signal, shutting down...
Apr 22 19:30:02 raspberrypi systemd[1]: Stopping Save/Restore Sound Card State...
Apr 22 19:30:02 raspberrypi systemd[1]: Stopping Bluetooth service...
Apr 22 19:30:02 raspberrypi systemd[1]: Stopping Regular background program processing daemon...
Apr 22 19:30:02 raspberrypi systemd[1]: Stopping Make remote CUPS printers available locally...
Apr 22 19:30:02 raspberrypi bluetoothd[683]: Terminating
Apr 22 19:30:02 raspberrypi bluetoothd[683]: Endpoint unregistered: sender=:1.27 path=/MediaEndpoint/A2DPSink/sbc
Apr 22 19:30:02 raspberrypi bluetoothd[683]: Endpoint unregistered: sender=:1.27 path=/MediaEndpoint/A2DPSource/sbc
Apr 22 19:30:02 raspberrypi systemd[1]: Stopping dphys-swapfile - set up, mount/unmount, and delete a swap file...
Apr 22 19:30:02 raspberrypi systemd[1]: Stopping Getty on tty1...
Apr 22 19:30:02 raspberrypi systemd[1]: glamor-test.service: Succeeded.
Apr 22 19:30:02 raspberrypi systemd[519]: run-rpc_pipefs.mount: Succeeded.
Apr 22 19:30:03 raspberrypi vncserver-x11-serviced[1287]: X Error of failed request:  BadWindow (invalid Window parameter)
Apr 22 19:30:03 raspberrypi vncserver-x11-serviced[1287]:   Major opcode of failed request:  2 (X_ChangeWindowAttributes)
Apr 22 19:30:03 raspberrypi vncserver-x11-serviced[1287]:   Resource id in failed request:  0x10000c6
Apr 22 19:30:03 raspberrypi vncserver-x11-serviced[1287]:   Serial number of failed request:  1441
Apr 22 19:30:03 raspberrypi vncserver-x11-serviced[1287]:   Current serial number in output stream:  1442
Apr 22 19:30:02 raspberrypi systemd[1]: Stopped Check for glamor.
Apr 22 19:30:03 raspberrypi vncserver-x11-serviced[689]: X connection to :0 broken (explicit kill or server shutdown).
Apr 22 19:30:03 raspberrypi pulseaudio[629]: X connection to :0 broken (explicit kill or server shutdown).
Apr 22 19:30:02 raspberrypi systemd[1]: gldriver-test.service: Succeeded.
Apr 22 19:30:03 raspberrypi vncserver-x11-serviced[1298]: vncserverui: Fatal IO error 11 (Resource temporarily unavailable) on X server :0.
Apr 22 19:30:02 raspberrypi systemd[1]: Stopped Check for v3d driver.
Apr 22 19:30:02 raspberrypi systemd[1]: Stopping Light Display Manager...
Apr 22 19:30:02 raspberrypi systemd[1]: openvpn.service: Succeeded.
Apr 22 19:30:03 raspberrypi systemd[1]: Stopped OpenVPN service.
Apr 22 19:30:03 raspberrypi systemd[1]: Stopping PackageKit Daemon...
Apr 22 19:30:03 raspberrypi systemd[1]: Stopping LSB: Switch to ondemand cpu governor (unless shift key is pressed)...
Apr 22 19:30:03 raspberrypi systemd[1]: Stopping LSB: rng-tools (Debian variant)...
Apr 22 19:30:03 raspberrypi systemd[1]: Condition check resulted in Turns off Raspberry Pi display backlight on shutdown/reboot being skipped.
Apr 22 19:30:04 raspberrypi sshd[421]: Received signal 15; terminating.
Apr 22 19:30:03 raspberrypi systemd[1]: rpi-eeprom-update.service: Succeeded.
Apr 22 19:30:04 raspberrypi rsyslogd[297]: [origin software="rsyslogd" swVersion="8.2102.0" x-pid="297" x-info="https://www.rsyslog.com"] exiting on signal 15.
Apr 22 19:30:03 raspberrypi systemd[1]: Stopped Check for Raspberry Pi EEPROM updates.
Apr 22 19:30:04 raspberrypi ModemManager[387]: <info>  ModemManager is shut down
Apr 22 19:30:03 raspberrypi systemd[1]: Stopping System Logging Service...
Apr 22 19:30:04 raspberrypi bluetoothd[683]: Stopping SDP server
Apr 22 19:30:03 raspberrypi systemd[1]: Stopping RealtimeKit Scheduling Policy Service...
Apr 22 19:30:05 raspberrypi uwi[1997]: Stopping UWI server...
Apr 22 19:30:04 raspberrypi bluetoothd[683]: Exit
Apr 22 19:30:03 raspberrypi systemd[1]: Stopping Serial Getty on ttyAMA0...
Apr 22 19:30:03 raspberrypi systemd[1]: Stopping OpenBSD Secure Shell server...
Apr 22 19:30:04 raspberrypi systemd[1]: Stopping Load/Save Random Seed...
Apr 22 19:30:04 raspberrypi systemd[1]: Stopping triggerhappy global hotkey daemon...
Apr 22 19:30:05 raspberrypi wittypi[1998]: Stopping Witty Pi 4 Daemon...
Apr 22 19:30:04 raspberrypi NetworkManager[277]: <info>  [1713807004.3938] modem-manager: ModemManager no longer available
Apr 22 19:30:06 raspberrypi wittypi[1998]: /etc/init.d/wittypi: line 25: kill: (366) - No such process
Apr 22 19:30:04 raspberrypi systemd[1]: Stopping Disk Manager...
Apr 22 19:30:04 raspberrypi systemd[1]: Stopping LSB: UUGear Web Interface initialize script...
Apr 22 19:30:04 raspberrypi systemd[1]: Stopping VNC Server in Service Mode daemon...
Apr 22 19:30:05 raspberrypi systemd[1]: Stopping LSB: Witty Pi 4 initialize script...
Apr 22 19:30:05 raspberrypi udisksd[328]: udisks daemon version 2.9.2 exiting
Apr 22 19:30:05 raspberrypi systemd[519]: pulseaudio.service: Main process exited, code=exited, status=1/FAILURE
Apr 22 19:30:06 raspberrypi vncserver-x11[398]: ServerManager: Server stopped
Apr 22 19:30:05 raspberrypi systemd[519]: pulseaudio.service: Failed with result 'exit-code'.
Apr 22 19:30:05 raspberrypi systemd[519]: pulseaudio.service: Consumed 2.092s CPU time.
Apr 22 19:30:06 raspberrypi systemd[519]: pulseaudio.service: Scheduled restart job, restart counter is at 1.
Apr 22 19:30:06 raspberrypi systemd[519]: Stopped Sound Service.
Apr 22 19:30:06 raspberrypi systemd[519]: pulseaudio.service: Consumed 2.092s CPU time.
Apr 22 19:30:06 raspberrypi systemd[519]: Starting Sound Service...
Apr 22 19:30:07 raspberrypi systemd[1]: cron.service: Succeeded.
Apr 22 19:30:07 raspberrypi systemd[1]: cron.service: Unit process 251 (cron) remains running after unit stopped.
Apr 22 19:30:07 raspberrypi systemd[1]: cron.service: Unit process 261 (sh) remains running after unit stopped.
Apr 22 19:30:07 raspberrypi systemd[1]: cron.service: Unit process 1150 (python3) remains running after unit stopped.
Apr 22 19:30:07 raspberrypi systemd[1]: cron.service: Unit process 2002 (journalctl) remains running after unit stopped.
Apr 22 19:30:07 raspberrypi systemd[1]: Stopped Regular background program processing daemon.
Apr 22 19:30:07 raspberrypi systemd[1]: cron.service: Consumed 21.446s CPU time.
Apr 22 19:30:07 raspberrypi systemd[1]: rsyslog.service: Succeeded.
Apr 22 19:30:07 raspberrypi systemd[1]: Stopped System Logging Service.
Apr 22 19:30:07 raspberrypi systemd[1]: triggerhappy.service: Succeeded.
Apr 22 19:30:07 raspberrypi systemd[1]: Stopped triggerhappy global hotkey daemon.
Apr 22 19:30:07 raspberrypi systemd[1]: udisks2.service: Succeeded.
Apr 22 19:30:07 raspberrypi systemd[1]: Stopped Disk Manager.
Apr 22 19:30:07 raspberrypi systemd[1]: udisks2.service: Consumed 1.828s CPU time.
Apr 22 19:30:07 raspberrypi systemd[1]: ModemManager.service: Succeeded.
Apr 22 19:30:07 raspberrypi systemd[1]: Stopped Modem Manager.
Apr 22 19:30:07 raspberrypi systemd[1]: ModemManager.service: Consumed 1.199s CPU time.
Apr 22 19:30:07 raspberrypi systemd[1]: vncserver-x11-serviced.service: Succeeded.
Apr 22 19:30:07 raspberrypi systemd[1]: Stopped VNC Server in Service Mode daemon.
Apr 22 19:30:07 raspberrypi systemd[1]: vncserver-x11-serviced.service: Consumed 5.886s CPU time.
Apr 22 19:30:07 raspberrypi systemd[1]: cups-browsed.service: Succeeded.
Apr 22 19:30:07 raspberrypi systemd[1]: Stopped Make remote CUPS printers available locally.
Apr 22 19:30:07 raspberrypi systemd[1]: ssh.service: Succeeded.
Apr 22 19:30:07 raspberrypi systemd[1]: Stopped OpenBSD Secure Shell server.
Apr 22 19:30:07 raspberrypi systemd[1]: getty@tty1.service: Succeeded.
Apr 22 19:30:07 raspberrypi systemd[1]: Stopped Getty on tty1.
Apr 22 19:30:08 raspberrypi systemd[1]: serial-getty@ttyAMA0.service: Succeeded.
Apr 22 19:30:08 raspberrypi systemd[1]: Stopped Serial Getty on ttyAMA0.
Apr 22 19:30:08 raspberrypi systemd[1]: rtkit-daemon.service: Succeeded.
Apr 22 19:30:08 raspberrypi systemd[1]: Stopped RealtimeKit Scheduling Policy Service.
Apr 22 19:30:08 raspberrypi systemd[1]: bluetooth.service: Succeeded.
Apr 22 19:30:08 raspberrypi systemd[1]: Stopped Bluetooth service.
Apr 22 19:30:08 raspberrypi systemd[1]: packagekit.service: Succeeded.
Apr 22 19:30:08 raspberrypi systemd[1]: Stopped PackageKit Daemon.
Apr 22 19:30:08 raspberrypi systemd[1]: packagekit.service: Consumed 1min 34.962s CPU time.
Apr 22 19:30:08 raspberrypi systemd[1]: run-rpc_pipefs.mount: Succeeded.
Apr 22 19:30:08 raspberrypi systemd[1]: Unmounted RPC Pipe File System.
Apr 22 19:30:08 raspberrypi systemd[1]: alsa-restore.service: Succeeded.
Apr 22 19:30:08 raspberrypi systemd[1]: Stopped Save/Restore Sound Card State.
Apr 22 19:30:08 raspberrypi systemd[1]: systemd-random-seed.service: Succeeded.
Apr 22 19:30:08 raspberrypi systemd[1]: Stopped Load/Save Random Seed.
Apr 22 19:30:08 raspberrypi systemd[1]: uwi.service: Succeeded.
Apr 22 19:30:08 raspberrypi systemd[1]: Stopped LSB: UUGear Web Interface initialize script.
Apr 22 19:30:08 raspberrypi dbus-daemon[250]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.56' (uid=1000 pid=2001 comm="/usr/bin/pulseaudio --daemonize=no --log-target=jo")
Apr 22 19:30:08 raspberrypi systemd[1]: wittypi.service: Succeeded.
Apr 22 19:30:08 raspberrypi systemd[1]: Stopped LSB: Witty Pi 4 initialize script.
Apr 22 19:30:08 raspberrypi systemd[1]: session-2.scope: Succeeded.
Apr 22 19:30:08 raspberrypi systemd[1]: Stopped Session 2 of user admin.
Apr 22 19:30:09 raspberrypi systemd-logind[319]: Session 2 logged out. Waiting for processes to exit.
Apr 22 19:30:09 raspberrypi systemd[519]: var-swap.swap: Succeeded.
Apr 22 19:30:09 raspberrypi systemd[1]: var-swap.swap: Succeeded.
Apr 22 19:30:09 raspberrypi systemd[1]: Deactivated swap /var/swap.
Apr 22 19:30:09 raspberrypi systemd[1]: dphys-swapfile.service: Succeeded.
Apr 22 19:30:09 raspberrypi systemd[1]: Stopped dphys-swapfile - set up, mount/unmount, and delete a swap file.
Apr 22 19:30:09 raspberrypi systemd[1]: raspi-config.service: Succeeded.
Apr 22 19:30:09 raspberrypi systemd[1]: Stopped LSB: Switch to ondemand cpu governor (unless shift key is pressed).
Apr 22 19:30:09 raspberrypi rngd[415]: stats: bits received from HRNG source: 60064
Apr 22 19:30:09 raspberrypi rngd[415]: stats: bits sent to kernel pool: 8704
Apr 22 19:30:09 raspberrypi rngd[415]: stats: entropy added to kernel pool: 8704
Apr 22 19:30:09 raspberrypi rngd[415]: stats: FIPS 140-2 successes: 3
Apr 22 19:30:09 raspberrypi rngd[415]: stats: FIPS 140-2 failures: 0
Apr 22 19:30:09 raspberrypi rngd[415]: stats: FIPS 140-2(2001-10-10) Monobit: 0
Apr 22 19:30:09 raspberrypi rngd[415]: stats: FIPS 140-2(2001-10-10) Poker: 0
Apr 22 19:30:09 raspberrypi rngd[415]: stats: FIPS 140-2(2001-10-10) Runs: 0
Apr 22 19:30:09 raspberrypi rngd[415]: stats: FIPS 140-2(2001-10-10) Long run: 0
Apr 22 19:30:09 raspberrypi rngd[415]: stats: FIPS 140-2(2001-10-10) Continuous run: 0
Apr 22 19:30:09 raspberrypi rngd[415]: stats: HRNG source speed: (min=136.837; avg=166.571; max=193.367)Kibits/s
Apr 22 19:30:09 raspberrypi rngd[415]: stats: FIPS tests speed: (min=32.885; avg=34.182; max=34.933)Mibits/s
Apr 22 19:30:09 raspberrypi rngd[415]: stats: Lowest ready-buffers level: 2
Apr 22 19:30:09 raspberrypi rngd[415]: stats: Entropy starvations: 0
Apr 22 19:30:09 raspberrypi rngd[415]: stats: Time spent starving for entropy: (min=0; avg=0.000; max=0)us
Apr 22 19:30:09 raspberrypi systemd[1]: Removed slice system-getty.slice.
Apr 22 19:30:09 raspberrypi rngd[415]: Exiting...
Apr 22 19:30:09 raspberrypi dbus-daemon[250]: [system] Activation via systemd failed for unit 'rtkit-daemon.service': Refusing activation, D-Bus is shutting down.
Apr 22 19:30:09 raspberrypi systemd[1]: Removed slice system-serial\x2dgetty.slice.
Apr 22 19:30:09 raspberrypi avahi-daemon[245]: Got SIGTERM, quitting.
Apr 22 19:30:09 raspberrypi avahi-daemon[245]: Leaving mDNS multicast group on interface usb0.IPv6 with address 2a00:fbc:e179:66fd:1d85:f1d8:1634:6124.
Apr 22 19:30:09 raspberrypi systemd[1]: Stopping Avahi mDNS/DNS-SD Stack...
Apr 22 19:30:09 raspberrypi avahi-daemon[245]: Leaving mDNS multicast group on interface usb0.IPv4 with address 192.168.0.33.
Apr 22 19:30:09 raspberrypi systemd[1]: bthelper@hci0.service: Succeeded.
Apr 22 19:30:09 raspberrypi avahi-daemon[245]: Leaving mDNS multicast group on interface lo.IPv6 with address ::1.
Apr 22 19:30:09 raspberrypi systemd[1]: Stopped Raspberry Pi bluetooth helper.
Apr 22 19:30:09 raspberrypi avahi-daemon[245]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1.
Apr 22 19:30:09 raspberrypi systemd[1]: Removed slice system-bthelper.slice.
Apr 22 19:30:09 raspberrypi avahi-daemon[245]: avahi-daemon 0.8 exiting.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopping CUPS Scheduler...
Apr 22 19:30:10 raspberrypi dbus-daemon[250]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.57' (uid=1000 pid=2001 comm="/usr/bin/pulseaudio --daemonize=no --log-target=jo")
Apr 22 19:30:10 raspberrypi systemd[1]: Stopping Configure Bluetooth Modems connected by UART...
Apr 22 19:30:10 raspberrypi systemd[1]: plymouth-quit-wait.service: Succeeded.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopped Hold until boot process finishes up.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopping Authorization Manager...
Apr 22 19:30:10 raspberrypi systemd[1]: rc-local.service: Succeeded.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopped /etc/rc.local Compatibility.
Apr 22 19:30:10 raspberrypi systemd[519]: Stopped target Bluetooth.
Apr 22 19:30:10 raspberrypi systemd[1]: avahi-daemon.service: Succeeded.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopped Avahi mDNS/DNS-SD Stack.
Apr 22 19:30:10 raspberrypi systemd[1]: polkit.service: Succeeded.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopped Authorization Manager.
Apr 22 19:30:10 raspberrypi systemd[1]: polkit.service: Consumed 1.727s CPU time.
Apr 22 19:30:10 raspberrypi systemd[1]: cups.service: Succeeded.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopped CUPS Scheduler.
Apr 22 19:30:10 raspberrypi systemd[1]: hciuart.service: Succeeded.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopped Configure Bluetooth Modems connected by UART.
Apr 22 19:30:10 raspberrypi systemd[1]: rng-tools-debian.service: Succeeded.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopped LSB: rng-tools (Debian variant).
Apr 22 19:30:10 raspberrypi systemd-logind[319]: Removed session 2.
Apr 22 19:30:10 raspberrypi dbus-daemon[250]: [system] Activation via systemd failed for unit 'rtkit-daemon.service': Refusing activation, D-Bus is shutting down.
Apr 22 19:30:10 raspberrypi dbus-daemon[250]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.58' (uid=1000 pid=2001 comm="/usr/bin/pulseaudio --daemonize=no --log-target=jo")
Apr 22 19:30:10 raspberrypi dbus-daemon[250]: [system] Activation via systemd failed for unit 'rtkit-daemon.service': Refusing activation, D-Bus is shutting down.
Apr 22 19:30:10 raspberrypi sudo[2013]: admin : PWD=/home/admin ; USER=root ; COMMAND=/usr/sbin/shutdown -r +15
Apr 22 19:30:10 raspberrypi systemd[1]: session-4.scope: Succeeded.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopped Session 4 of user admin.
Apr 22 19:30:10 raspberrypi systemd[1]: session-4.scope: Consumed 37.115s CPU time.
Apr 22 19:30:10 raspberrypi systemd[1]: Stopping User Login Management...
Apr 22 19:30:10 raspberrypi systemd[519]: Stopped target Main User Target.
Apr 22 19:30:10 raspberrypi sudo[2013]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 22 19:30:10 raspberrypi systemd[1]: Stopping User Manager for UID 1000...
Apr 22 19:30:10 raspberrypi systemd[519]: Stopped target Sound Card.
Apr 22 19:30:10 raspberrypi gvfsd[1097]: A connection to the bus can't be made
Apr 22 19:30:10 raspberrypi systemd[519]: Stopping D-Bus User Message Bus...
Apr 22 19:30:10 raspberrypi gvfsd[1360]: A connection to the bus can't be made
Apr 22 19:30:10 raspberrypi systemd[519]: Stopping Virtual filesystem service - Apple File Conduit monitor...
Apr 22 19:30:10 raspberrypi dbus-daemon[250]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.59' (uid=1000 pid=2001 comm="/usr/bin/pulseaudio --daemonize=no --log-target=jo")
Apr 22 19:30:10 raspberrypi systemd[519]: Stopping Virtual filesystem service...
Apr 22 19:30:10 raspberrypi dbus-daemon[250]: [system] Activation via systemd failed for unit 'rtkit-daemon.service': Refusing activation, D-Bus is shutting down.
Apr 22 19:30:10 raspberrypi systemd[519]: Stopping Virtual filesystem service - GNOME Online Accounts monitor...
Apr 22 19:30:10 raspberrypi systemd[519]: Stopping Virtual filesystem service - digital camera monitor...
Apr 22 19:30:10 raspberrypi systemd[519]: Stopping Virtual filesystem service - Media Transfer Protocol monitor...
Apr 22 19:30:10 raspberrypi systemd[519]: Stopping Virtual filesystem service - disk device monitor...
Apr 22 19:30:10 raspberrypi systemd[519]: Stopping Multimedia Service...
Apr 22 19:30:11 raspberrypi systemd[1]: systemd-logind.service: Succeeded.
Apr 22 19:30:11 raspberrypi dbus-daemon[250]: [system] Activating via systemd: service name='org.freedesktop.login1' unit='dbus-org.freedesktop.login1.service' requested by ':1.60' (uid=0 pid=2014 comm="shutdown -r +15 ")
Apr 22 19:30:11 raspberrypi systemd[1]: Stopped User Login Management.
Apr 22 19:30:11 raspberrypi systemd[1]: systemd-logind.service: Consumed 1.407s CPU time.
Apr 22 19:30:11 raspberrypi dbus-daemon[250]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.login1.service': Refusing activation, D-Bus is shutting down.
Apr 22 19:30:11 raspberrypi systemd[519]: dbus.service: Succeeded.
Apr 22 19:30:11 raspberrypi dbus-daemon[250]: [system] Activating via systemd: service name='org.freedesktop.login1' unit='dbus-org.freedesktop.login1.service' requested by ':1.60' (uid=0 pid=2014 comm="shutdown -r +15 ")
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped D-Bus User Message Bus.
Apr 22 19:30:11 raspberrypi dbus-daemon[250]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.login1.service': Refusing activation, D-Bus is shutting down.
Apr 22 19:30:11 raspberrypi systemd[519]: gvfs-udisks2-volume-monitor.service: Succeeded.
Apr 22 19:30:11 raspberrypi sudo[2013]: pam_unix(sudo:session): session closed for user root
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped Virtual filesystem service - disk device monitor.
Apr 22 19:30:11 raspberrypi systemd[1]: run-user-1000-gvfs.mount: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[1]: Unmounted /run/user/1000/gvfs.
Apr 22 19:30:11 raspberrypi systemd[519]: run-user-1000-gvfs.mount: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: gvfs-mtp-volume-monitor.service: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[1]: lightdm.service: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped Virtual filesystem service - Media Transfer Protocol monitor.
Apr 22 19:30:11 raspberrypi systemd[519]: gvfs-goa-volume-monitor.service: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped Virtual filesystem service - GNOME Online Accounts monitor.
Apr 22 19:30:11 raspberrypi systemd[1]: Stopped Light Display Manager.
Apr 22 19:30:11 raspberrypi systemd[1]: lightdm.service: Consumed 6.867s CPU time.
Apr 22 19:30:11 raspberrypi systemd[519]: gvfs-afc-volume-monitor.service: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped Virtual filesystem service - Apple File Conduit monitor.
Apr 22 19:30:11 raspberrypi systemd[519]: gvfs-gphoto2-volume-monitor.service: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[1]: Starting Show Plymouth Power Off Screen...
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped Virtual filesystem service - digital camera monitor.
Apr 22 19:30:11 raspberrypi systemd[519]: pulseaudio.service: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped Sound Service.
Apr 22 19:30:11 raspberrypi systemd[519]: pipewire.service: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[1]: Received SIGRTMIN+20 from PID 2022 (plymouthd).
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped Multimedia Service.
Apr 22 19:30:11 raspberrypi systemd[519]: gvfs-daemon.service: Succeeded.
Apr 22 19:30:11 raspberrypi crontab[2020]: (admin) LIST (admin)
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped Virtual filesystem service.
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped target Basic System.
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped target Paths.
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped target Sockets.
Apr 22 19:30:11 raspberrypi systemd[519]: Stopped target Timers.
Apr 22 19:30:11 raspberrypi systemd[519]: dbus.socket: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Closed D-Bus User Message Bus Socket.
Apr 22 19:30:11 raspberrypi systemd[519]: dirmngr.socket: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Closed GnuPG network certificate management daemon.
Apr 22 19:30:11 raspberrypi systemd[519]: gpg-agent-browser.socket: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
Apr 22 19:30:11 raspberrypi systemd[519]: gpg-agent-extra.socket: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
Apr 22 19:30:11 raspberrypi systemd[519]: gpg-agent-ssh.socket: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Closed GnuPG cryptographic agent (ssh-agent emulation).
Apr 22 19:30:11 raspberrypi systemd[519]: gpg-agent.socket: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Closed GnuPG cryptographic agent and passphrase cache.
Apr 22 19:30:11 raspberrypi systemd[519]: pipewire.socket: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Closed Multimedia System.
Apr 22 19:30:11 raspberrypi crontab[2024]: (admin) LIST (admin)
Apr 22 19:30:11 raspberrypi systemd[519]: pk-debconf-helper.socket: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Closed debconf communication socket.
Apr 22 19:30:11 raspberrypi systemd[519]: pulseaudio.socket: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Closed Sound System.
Apr 22 19:30:11 raspberrypi systemd[519]: Removed slice User Application Slice.
Apr 22 19:30:11 raspberrypi systemd[519]: app.slice: Consumed 5.635s CPU time.
Apr 22 19:30:11 raspberrypi systemd[519]: Reached target Shutdown.
Apr 22 19:30:11 raspberrypi systemd[1]: Started Show Plymouth Power Off Screen.
Apr 22 19:30:11 raspberrypi systemd[519]: systemd-exit.service: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[519]: Finished Exit the Session.
Apr 22 19:30:11 raspberrypi systemd[519]: Reached target Exit the Session.
Apr 22 19:30:11 raspberrypi systemd[1]: user@1000.service: Succeeded.
Apr 22 19:30:11 raspberrypi systemd[1]: Stopped User Manager for UID 1000.
Apr 22 19:30:11 raspberrypi systemd[1]: user@1000.service: Consumed 7.997s CPU time.
Apr 22 19:30:11 raspberrypi systemd[1]: Stopping User Runtime Directory /run/user/1000...
Apr 22 19:30:12 raspberrypi systemd[1]: run-user-1000.mount: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Unmounted /run/user/1000.
Apr 22 19:30:12 raspberrypi systemd[1]: user-runtime-dir@1000.service: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped User Runtime Directory /run/user/1000.
Apr 22 19:30:12 raspberrypi systemd[1]: Removed slice User Slice of UID 1000.
Apr 22 19:30:12 raspberrypi systemd[1]: user-1000.slice: Consumed 46.093s CPU time.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopping Permit User Sessions...
Apr 22 19:30:12 raspberrypi systemd[1]: systemd-user-sessions.service: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped Permit User Sessions.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped target Network.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped target Remote File Systems.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped target Remote File Systems (Pre).
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped target NFS client services.
Apr 22 19:30:12 raspberrypi NetworkManager[277]: <info>  [1713807012.2369] caught SIGTERM, shutting down normally.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopping Network Manager...
Apr 22 19:30:12 raspberrypi systemd[1]: Stopping Raise network interfaces...
Apr 22 19:30:12 raspberrypi systemd[1]: Stopping WPA supplicant...
Apr 22 19:30:12 raspberrypi NetworkManager[277]: <info>  [1713807012.3632] dhcp4 (usb0): canceled DHCP transaction
Apr 22 19:30:12 raspberrypi NetworkManager[277]: <info>  [1713807012.3750] dhcp4 (usb0): state changed bound -> terminated
Apr 22 19:30:12 raspberrypi NetworkManager[277]: <info>  [1713807012.3855] dhcp6 (usb0): canceled DHCP transaction
Apr 22 19:30:12 raspberrypi NetworkManager[277]: <info>  [1713807012.3858] dhcp6 (usb0): state changed bound -> terminated
Apr 22 19:30:12 raspberrypi systemd[1]: wpa_supplicant.service: Succeeded.
Apr 22 19:30:12 raspberrypi NetworkManager[277]: <info>  [1713807012.4465] manager: NetworkManager state is now CONNECTED_SITE
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped WPA supplicant.
Apr 22 19:30:12 raspberrypi dbus-daemon[250]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.5' (uid=0 pid=277 comm="/usr/sbin/NetworkManager --no-daemon ")
Apr 22 19:30:12 raspberrypi dbus-daemon[250]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.nm-dispatcher.service': Refusing activation, D-Bus is shutting down.
Apr 22 19:30:12 raspberrypi NetworkManager[277]: <info>  [1713807012.5101] device (wlan0): state change: unavailable -> unmanaged (reason 'unmanaged', sys-iface-state: 'managed')
Apr 22 19:30:12 raspberrypi NetworkManager[277]: <info>  [1713807012.5377] device (wlan0): set-hw-addr: reset MAC address to B8:27:EB:83:9D:06 (unmanage)
Apr 22 19:30:12 raspberrypi dbus-daemon[250]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.5' (uid=0 pid=277 comm="/usr/sbin/NetworkManager --no-daemon ")
Apr 22 19:30:12 raspberrypi dbus-daemon[250]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.nm-dispatcher.service': Refusing activation, D-Bus is shutting down.
Apr 22 19:30:12 raspberrypi NetworkManager[277]: <info>  [1713807012.7029] exiting (success)
Apr 22 19:30:12 raspberrypi systemd[1]: NetworkManager.service: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped Network Manager.
Apr 22 19:30:12 raspberrypi systemd[1]: NetworkManager.service: Consumed 3.468s CPU time.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopping D-Bus System Message Bus...
Apr 22 19:30:12 raspberrypi systemd[1]: dbus.service: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped D-Bus System Message Bus.
Apr 22 19:30:12 raspberrypi systemd[1]: dbus.service: Consumed 5.057s CPU time.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped target Basic System.
Apr 22 19:30:12 raspberrypi systemd[1]: systemd-ask-password-plymouth.path: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped Forward Password Requests to Plymouth Directory Watch.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped target Paths.
Apr 22 19:30:12 raspberrypi systemd[1]: cups.path: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped CUPS Scheduler.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped target Slices.
Apr 22 19:30:12 raspberrypi systemd[1]: Removed slice User and Session Slice.
Apr 22 19:30:12 raspberrypi systemd[1]: user.slice: Consumed 46.093s CPU time.
Apr 22 19:30:12 raspberrypi systemd[1]: Stopped target Sockets.
Apr 22 19:30:12 raspberrypi systemd[1]: avahi-daemon.socket: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Closed Avahi mDNS/DNS-SD Stack Activation Socket.
Apr 22 19:30:12 raspberrypi systemd[1]: cups.socket: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Closed CUPS Scheduler.
Apr 22 19:30:12 raspberrypi systemd[1]: dbus.socket: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Closed D-Bus System Message Bus Socket.
Apr 22 19:30:12 raspberrypi systemd[1]: pcscd.socket: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Closed PC/SC Smart Card Daemon Activation Socket.
Apr 22 19:30:12 raspberrypi systemd[1]: syslog.socket: Succeeded.
Apr 22 19:30:12 raspberrypi systemd[1]: Closed Syslog Socket.
Apr 22 19:30:13 raspberrypi systemd[1]: triggerhappy.socket: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Closed triggerhappy.socket.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped target System Initialization.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped target Local Encrypted Volumes.
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-ask-password-wall.path: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped target Swap.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopping Restore / save the current clock...
Apr 22 19:30:13 raspberrypi systemd[1]: Stopping Update UTMP about System Boot/Shutdown...
Apr 22 19:30:13 raspberrypi systemd[1]: networking.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped Raise network interfaces.
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-sysctl.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped Apply Kernel Variables.
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-modules-load.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped Load Kernel Modules.
Apr 22 19:30:13 raspberrypi systemd[1]: fake-hwclock.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped Restore / save the current clock.
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-update-utmp.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped Update UTMP about System Boot/Shutdown.
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-tmpfiles-setup.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped Create Volatile Files and Directories.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped target Local File Systems.
Apr 22 19:30:13 raspberrypi systemd[1]: Unmounting /boot...
Apr 22 19:30:13 raspberrypi systemd[1]: boot.mount: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Unmounted /boot.
Apr 22 19:30:13 raspberrypi systemd[1]: Reached target Unmount All Filesystems.
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-fsck@dev-disk-by\x2dpartuuid-dc50bea6\x2d01.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped File System Check on /dev/disk/by-partuuid/dc50bea6-01.
Apr 22 19:30:13 raspberrypi systemd[1]: Removed slice system-systemd\x2dfsck.slice.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped target Local File Systems (Pre).
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-tmpfiles-setup-dev.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped Create Static Device Nodes in /dev.
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-sysusers.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped Create System Users.
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-remount-fs.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped Remount Root and Kernel File Systems.
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-fsck-root.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Stopped File System Check on Root Device.
Apr 22 19:30:13 raspberrypi systemd[1]: Reached target Shutdown.
Apr 22 19:30:13 raspberrypi systemd[1]: Reached target Final Step.
Apr 22 19:30:13 raspberrypi systemd[1]: systemd-poweroff.service: Succeeded.
Apr 22 19:30:13 raspberrypi systemd[1]: Finished Power-Off.
Apr 22 19:30:13 raspberrypi systemd[1]: Reached target Power-Off.
Apr 22 19:30:13 raspberrypi systemd[1]: Shutting down.
Apr 22 19:30:13 raspberrypi systemd-shutdown[1]: Syncing filesystems and block devices.
Apr 22 19:30:15 raspberrypi systemd-shutdown[1]: Sending SIGTERM to remaining processes...
Apr 22 19:30:15 raspberrypi systemd-journald[110]: Journal stopped
-- Boot 6e0658dc97b5481392b7868841edc65c --
Apr 22 19:30:15 raspberrypi kernel: Booting Linux on physical CPU 0x0
Apr 22 19:30:15 raspberrypi kernel: Linux version 6.1.21+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1642 Mon Apr  3 17:19:14 BST 2023
Apr 22 19:30:15 raspberrypi kernel: CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
Apr 22 19:30:15 raspberrypi kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
Apr 22 19:30:15 raspberrypi kernel: OF: fdt: Machine model: Raspberry Pi Zero W Rev 1.1
Apr 22 19:30:15 raspberrypi kernel: random: crng init done
Apr 22 19:30:15 raspberrypi kernel: Memory policy: Data cache writeback
Apr 22 19:30:15 raspberrypi kernel: Reserved memory: created CMA memory pool at 0x07c00000, size 320 MiB
Apr 22 19:30:15 raspberrypi kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Apr 22 19:30:15 raspberrypi kernel: Zone ranges:
Apr 22 19:30:15 raspberrypi kernel:   Normal   [mem 0x0000000000000000-0x000000001bffffff]
Apr 22 19:30:15 raspberrypi kernel: Movable zone start for each node
Apr 22 19:30:15 raspberrypi kernel: Early memory node ranges
Apr 22 19:30:15 raspberrypi kernel:   node   0: [mem 0x0000000000000000-0x000000001bffffff]
Apr 22 19:30:15 raspberrypi kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000001bffffff]
Apr 22 19:30:15 raspberrypi kernel: pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
Apr 22 19:30:15 raspberrypi kernel: pcpu-alloc: [0] 0 
Apr 22 19:30:15 raspberrypi kernel: Built 1 zonelists, mobility grouping on.  Total pages: 113680
Apr 22 19:30:15 raspberrypi kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_hdmi=0 video=Composite-1:720x480@60i smsc95xx.macaddr=B8:27:EB:D6:C8:53 vc_mem.mem_base=0x1ec00000 vc_mem.mem_size=0x20000000  console=ttyAMA0,115200 console=tty1 root=PARTUUID=dc50bea6-02 rootfstype=ext4 fsck.repair=yes rootwait quiet splash plymouth.ignore-serial-consoles cfg80211.ieee80211_regdom=GB
Apr 22 19:30:15 raspberrypi kernel: Unknown kernel command line parameters "splash", will be passed to user space.
Apr 22 19:30:15 raspberrypi kernel: Dentry cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: Inode-cache hash table entries: 32768 (order: 5, 131072 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Apr 22 19:30:15 raspberrypi kernel: Memory: 111352K/458752K available (8985K kernel code, 1450K rwdata, 2772K rodata, 432K init, 589K bss, 19720K reserved, 327680K cma-reserved)
Apr 22 19:30:15 raspberrypi kernel: SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Apr 22 19:30:15 raspberrypi kernel: ftrace: allocating 33370 entries in 98 pages
Apr 22 19:30:15 raspberrypi kernel: ftrace: allocated 98 pages with 3 groups
Apr 22 19:30:15 raspberrypi kernel: trace event string verifier disabled
Apr 22 19:30:15 raspberrypi kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Apr 22 19:30:15 raspberrypi kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Apr 22 19:30:15 raspberrypi kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Apr 22 19:30:15 raspberrypi kernel: bcm2835: system timer (irq = 27)
Apr 22 19:30:15 raspberrypi kernel: Console: colour dummy device 80x30
Apr 22 19:30:15 raspberrypi kernel: printk: console [tty1] enabled
Apr 22 19:30:15 raspberrypi kernel: Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792)
Apr 22 19:30:15 raspberrypi kernel: pid_max: default: 32768 minimum: 301
Apr 22 19:30:15 raspberrypi kernel: LSM: Security Framework initializing
Apr 22 19:30:15 raspberrypi kernel: Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: cgroup: Disabling memory control group subsystem
Apr 22 19:30:15 raspberrypi kernel: CPU: Testing write buffer coherency: ok
Apr 22 19:30:15 raspberrypi kernel: cblist_init_generic: Setting adjustable number of callback queues.
Apr 22 19:30:15 raspberrypi kernel: cblist_init_generic: Setting shift to 0 and lim to 1.
Apr 22 19:30:15 raspberrypi kernel: cblist_init_generic: Setting shift to 0 and lim to 1.
Apr 22 19:30:15 raspberrypi kernel: Setting up static identity map for 0x8220 - 0x8258
Apr 22 19:30:15 raspberrypi kernel: devtmpfs: initialized
Apr 22 19:30:15 raspberrypi kernel: VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
Apr 22 19:30:15 raspberrypi kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Apr 22 19:30:15 raspberrypi kernel: futex hash table entries: 256 (order: -1, 3072 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: pinctrl core: initialized pinctrl subsystem
Apr 22 19:30:15 raspberrypi kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Apr 22 19:30:15 raspberrypi kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations
Apr 22 19:30:15 raspberrypi kernel: audit: initializing netlink subsys (disabled)
Apr 22 19:30:15 raspberrypi kernel: thermal_sys: Registered thermal governor 'step_wise'
Apr 22 19:30:15 raspberrypi kernel: hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
Apr 22 19:30:15 raspberrypi kernel: hw-breakpoint: maximum watchpoint size is 4 bytes.
Apr 22 19:30:15 raspberrypi kernel: Serial: AMBA PL011 UART driver
Apr 22 19:30:15 raspberrypi kernel: audit: type=2000 audit(0.140:1): state=initialized audit_enabled=0 res=1
Apr 22 19:30:15 raspberrypi kernel: bcm2835-mbox 2000b880.mailbox: mailbox enabled
Apr 22 19:30:15 raspberrypi kernel: platform 20801000.csi: Fixed dependency cycle(s) with /soc/i2c0mux/i2c@1/imx477@1a
Apr 22 19:30:15 raspberrypi kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2023-03-17T10:52:42, variant start
Apr 22 19:30:15 raspberrypi kernel: raspberrypi-firmware soc:firmware: Firmware hash is 82f3750a65fadae9a38077e3c2e217ad158c8d54
Apr 22 19:30:15 raspberrypi kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
Apr 22 19:30:15 raspberrypi kernel: bcm2835-dma 20007000.dma: DMA legacy API manager, dmachans=0x1
Apr 22 19:30:15 raspberrypi kernel: SCSI subsystem initialized
Apr 22 19:30:15 raspberrypi kernel: usbcore: registered new interface driver usbfs
Apr 22 19:30:15 raspberrypi kernel: usbcore: registered new interface driver hub
Apr 22 19:30:15 raspberrypi kernel: usbcore: registered new device driver usb
Apr 22 19:30:15 raspberrypi kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator
Apr 22 19:30:15 raspberrypi kernel: usb_phy_generic phy: dummy supplies not allowed for exclusive requests
Apr 22 19:30:15 raspberrypi kernel: pps_core: LinuxPPS API ver. 1 registered
Apr 22 19:30:15 raspberrypi kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Apr 22 19:30:15 raspberrypi kernel: PTP clock support registered
Apr 22 19:30:15 raspberrypi kernel: clocksource: Switched to clocksource timer
Apr 22 19:30:15 raspberrypi kernel: VFS: Disk quotas dquot_6.6.0
Apr 22 19:30:15 raspberrypi kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Apr 22 19:30:15 raspberrypi kernel: FS-Cache: Loaded
Apr 22 19:30:15 raspberrypi kernel: CacheFiles: Loaded
Apr 22 19:30:15 raspberrypi kernel: NET: Registered PF_INET protocol family
Apr 22 19:30:15 raspberrypi kernel: IP idents hash table entries: 8192 (order: 4, 65536 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 0, 4096 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: TCP established hash table entries: 4096 (order: 2, 16384 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: TCP bind hash table entries: 4096 (order: 3, 32768 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: TCP: Hash tables configured (established 4096 bind 4096)
Apr 22 19:30:15 raspberrypi kernel: UDP hash table entries: 256 (order: 0, 4096 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: UDP-Lite hash table entries: 256 (order: 0, 4096 bytes, linear)
Apr 22 19:30:15 raspberrypi kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Apr 22 19:30:15 raspberrypi kernel: RPC: Registered named UNIX socket transport module.
Apr 22 19:30:15 raspberrypi kernel: RPC: Registered udp transport module.
Apr 22 19:30:15 raspberrypi kernel: RPC: Registered tcp transport module.
Apr 22 19:30:15 raspberrypi kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Apr 22 19:30:15 raspberrypi kernel: armv6-pmu arm-pmu: hw perfevents: no irqs for PMU, sampling events not supported
Apr 22 19:30:15 raspberrypi kernel: hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available
Apr 22 19:30:15 raspberrypi kernel: Initialise system trusted keyrings
Apr 22 19:30:15 raspberrypi kernel: workingset: timestamp_bits=14 max_order=17 bucket_order=3
Apr 22 19:30:15 raspberrypi kernel: zbud: loaded
Apr 22 19:30:15 raspberrypi kernel: NFS: Registering the id_resolver key type
Apr 22 19:30:15 raspberrypi kernel: Key type id_resolver registered
Apr 22 19:30:15 raspberrypi kernel: Key type id_legacy registered
Apr 22 19:30:15 raspberrypi kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Apr 22 19:30:15 raspberrypi kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
Apr 22 19:30:15 raspberrypi kernel: Key type asymmetric registered
Apr 22 19:30:15 raspberrypi kernel: Asymmetric key parser 'x509' registered
Apr 22 19:30:15 raspberrypi kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
Apr 22 19:30:15 raspberrypi kernel: io scheduler mq-deadline registered
Apr 22 19:30:15 raspberrypi kernel: io scheduler kyber registered
Apr 22 19:30:15 raspberrypi kernel: simple-framebuffer 1eaa9000.framebuffer: framebuffer at 0x1eaa9000, 0x151800 bytes
Apr 22 19:30:15 raspberrypi kernel: simple-framebuffer 1eaa9000.framebuffer: format=a8r8g8b8, mode=720x480x32, linelength=2880
Apr 22 19:30:15 raspberrypi kernel: Console: switching to colour frame buffer device 90x30
Apr 22 19:30:15 raspberrypi kernel: simple-framebuffer 1eaa9000.framebuffer: fb0: simplefb registered!
Apr 22 19:30:15 raspberrypi kernel: Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
Apr 22 19:30:15 raspberrypi kernel: bcm2835-rng 20104000.rng: hwrng registered
Apr 22 19:30:15 raspberrypi kernel: vc-mem: phys_addr:0x00000000 mem_base=0x1ec00000 mem_size:0x20000000(512 MiB)
Apr 22 19:30:15 raspberrypi kernel: gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000
Apr 22 19:30:15 raspberrypi kernel: brd: module loaded
Apr 22 19:30:15 raspberrypi kernel: loop: module loaded
Apr 22 19:30:15 raspberrypi kernel: Loading iSCSI transport class v2.0-870.
Apr 22 19:30:15 raspberrypi kernel: usbcore: registered new interface driver smsc95xx
Apr 22 19:30:15 raspberrypi kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Apr 22 19:30:15 raspberrypi kernel: Core Release: 2.80a
Apr 22 19:30:15 raspberrypi kernel: Setting default values for core params
Apr 22 19:30:15 raspberrypi kernel: Finished setting default values for core params
Apr 22 19:30:15 raspberrypi kernel: Using Buffer DMA mode
Apr 22 19:30:15 raspberrypi kernel: Periodic Transfer Interrupt Enhancement - disabled
Apr 22 19:30:15 raspberrypi kernel: Multiprocessor Interrupt Enhancement - disabled
Apr 22 19:30:15 raspberrypi kernel: OTG VER PARAM: 0, OTG VER FLAG: 0
Apr 22 19:30:15 raspberrypi kernel: Dedicated Tx FIFOs mode
Apr 22 19:30:15 raspberrypi kernel: 
Apr 22 19:30:15 raspberrypi kernel: WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = c7d04000 dma = 0x87d04000 len=9024
Apr 22 19:30:15 raspberrypi kernel: FIQ FSM acceleration enabled for :
                                    Non-periodic Split Transactions
                                    Periodic Split Transactions
                                    High-Speed Isochronous Endpoints
                                    Interrupt/Control Split Transaction hack enabled
Apr 22 19:30:15 raspberrypi kernel: dwc_otg: Microframe scheduler enabled
Apr 22 19:30:15 raspberrypi kernel: 
Apr 22 19:30:15 raspberrypi kernel: WARN::hcd_init_fiq:457: FIQ on core 0
Apr 22 19:30:15 raspberrypi kernel: 
Apr 22 19:30:15 raspberrypi kernel: WARN::hcd_init_fiq:458: FIQ ASM at c065d3d8 length 36
Apr 22 19:30:15 raspberrypi kernel: 
Apr 22 19:30:15 raspberrypi kernel: WARN::hcd_init_fiq:497: MPHI regs_base at dc810000
Apr 22 19:30:15 raspberrypi kernel: dwc_otg 20980000.usb: DWC OTG Controller
Apr 22 19:30:15 raspberrypi kernel: dwc_otg 20980000.usb: new USB bus registered, assigned bus number 1
Apr 22 19:30:15 raspberrypi kernel: dwc_otg 20980000.usb: irq 56, io mem 0x00000000
Apr 22 19:30:15 raspberrypi kernel: Init: Port Power? op_state=1
Apr 22 19:30:15 raspberrypi kernel: Init: Power Port (0)
Apr 22 19:30:15 raspberrypi kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01
Apr 22 19:30:15 raspberrypi kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 22 19:30:15 raspberrypi kernel: usb usb1: Product: DWC OTG Controller
Apr 22 19:30:15 raspberrypi kernel: usb usb1: Manufacturer: Linux 6.1.21+ dwc_otg_hcd
Apr 22 19:30:15 raspberrypi kernel: usb usb1: SerialNumber: 20980000.usb
Apr 22 19:30:15 raspberrypi kernel: hub 1-0:1.0: USB hub found
Apr 22 19:30:15 raspberrypi kernel: hub 1-0:1.0: 1 port detected
Apr 22 19:30:15 raspberrypi kernel: dwc_otg: FIQ enabled
Apr 22 19:30:15 raspberrypi kernel: dwc_otg: NAK holdoff enabled
Apr 22 19:30:15 raspberrypi kernel: dwc_otg: FIQ split-transaction FSM enabled
Apr 22 19:30:15 raspberrypi kernel: Module dwc_common_port init
Apr 22 19:30:15 raspberrypi kernel: usbcore: registered new interface driver usb-storage
Apr 22 19:30:15 raspberrypi kernel: mousedev: PS/2 mouse device common for all mice
Apr 22 19:30:15 raspberrypi kernel: sdhci: Secure Digital Host Controller Interface driver
Apr 22 19:30:15 raspberrypi kernel: sdhci: Copyright(c) Pierre Ossman
Apr 22 19:30:15 raspberrypi kernel: sdhci-pltfm: SDHCI platform and OF driver helper
Apr 22 19:30:15 raspberrypi kernel: ledtrig-cpu: registered to indicate activity on CPUs
Apr 22 19:30:15 raspberrypi kernel: hid: raw HID events driver (C) Jiri Kosina
Apr 22 19:30:15 raspberrypi kernel: usbcore: registered new interface driver usbhid
Apr 22 19:30:15 raspberrypi kernel: usbhid: USB HID core driver
Apr 22 19:30:15 raspberrypi kernel: bcm2835_vchiq 2000b840.mailbox: there is not valid maps for state default
Apr 22 19:30:15 raspberrypi kernel: Initializing XFRM netlink socket
Apr 22 19:30:15 raspberrypi kernel: NET: Registered PF_PACKET protocol family
Apr 22 19:30:15 raspberrypi kernel: Key type dns_resolver registered
Apr 22 19:30:15 raspberrypi kernel: registered taskstats version 1
Apr 22 19:30:15 raspberrypi kernel: Loading compiled-in X.509 certificates
Apr 22 19:30:15 raspberrypi kernel: uart-pl011 20201000.serial: there is not valid maps for state default
Apr 22 19:30:15 raspberrypi kernel: uart-pl011 20201000.serial: cts_event_workaround enabled
Apr 22 19:30:15 raspberrypi kernel: 20201000.serial: ttyAMA0 at MMIO 0x20201000 (irq = 81, base_baud = 0) is a PL011 rev2
Apr 22 19:30:15 raspberrypi kernel: printk: console [ttyAMA0] enabled
Apr 22 19:30:15 raspberrypi kernel: 20215040.serial: ttyS0 at MMIO 0x20215040 (irq = 53, base_baud = 31250000) is a 16550
Apr 22 19:30:15 raspberrypi kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Apr 22 19:30:15 raspberrypi kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Apr 22 19:30:15 raspberrypi kernel: mmc-bcm2835 20300000.mmcnr: mmc_debug:0 mmc_debug2:0
Apr 22 19:30:15 raspberrypi kernel: mmc-bcm2835 20300000.mmcnr: DMA channel allocated
Apr 22 19:30:15 raspberrypi kernel: sdhost: log_buf @ 21aa3c98 (87d03000)
Apr 22 19:30:15 raspberrypi kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
Apr 22 19:30:15 raspberrypi kernel: of_cfs_init
Apr 22 19:30:15 raspberrypi kernel: of_cfs_init: OK
Apr 22 19:30:15 raspberrypi kernel: Waiting for root device PARTUUID=dc50bea6-02...
Apr 22 19:30:15 raspberrypi kernel: mmc0: host does not support reading read-only switch, assuming write-enable
Apr 22 19:30:15 raspberrypi kernel: mmc0: new high speed SDHC card at address aaaa
Apr 22 19:30:15 raspberrypi kernel: mmcblk0: mmc0:aaaa SP32G 29.7 GiB 
Apr 22 19:30:15 raspberrypi kernel:  mmcblk0: p1 p2
Apr 22 19:30:15 raspberrypi kernel: mmcblk0: mmc0:aaaa SP32G 29.7 GiB (quirks 0x00004000)
Apr 22 19:30:15 raspberrypi kernel: mmc1: new high speed SDIO card at address 0001
Apr 22 19:30:15 raspberrypi kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none.
Apr 22 19:30:15 raspberrypi kernel: VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Apr 22 19:30:15 raspberrypi kernel: devtmpfs: mounted
Apr 22 19:30:15 raspberrypi kernel: Freeing unused kernel image (initmem) memory: 432K
Apr 22 19:30:15 raspberrypi kernel: Kernel memory protection not selected by kernel config.
Apr 22 19:30:15 raspberrypi kernel: Run /sbin/init as init process
Apr 22 19:30:15 raspberrypi kernel:   with arguments:
Apr 22 19:30:15 raspberrypi kernel:     /sbin/init
Apr 22 19:30:15 raspberrypi kernel:     splash
Apr 22 19:30:15 raspberrypi kernel:   with environment:
Apr 22 19:30:15 raspberrypi kernel:     HOME=/
Apr 22 19:30:15 raspberrypi kernel:     TERM=linux
Apr 22 19:30:15 raspberrypi systemd[1]: System time before build time, advancing clock.
Apr 22 19:30:15 raspberrypi kernel: NET: Registered PF_INET6 protocol family
Apr 22 19:30:15 raspberrypi kernel: Segment Routing with IPv6
Apr 22 19:30:15 raspberrypi kernel: In-situ OAM (IOAM) with IPv6
Apr 22 19:30:15 raspberrypi systemd[1]: systemd 247.3-7+rpi1+deb11u2 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +ZSTD +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=unified)
Apr 22 19:30:15 raspberrypi systemd[1]: Detected architecture arm.
Apr 22 19:30:15 raspberrypi systemd[1]: Set hostname to <raspberrypi>.
Apr 22 19:30:15 raspberrypi systemd[1]: Using hardware watchdog 'Broadcom BCM2835 Watchdog timer', version 0, device /dev/watchdog
Apr 22 19:30:15 raspberrypi systemd[1]: Set hardware watchdog to 15s.
Apr 22 19:30:15 raspberrypi kernel: uart-pl011 20201000.serial: no DMA platform data
Apr 22 19:30:15 raspberrypi systemd[1]: /lib/systemd/system/plymouth-start.service:16: Unit configured to use KillMode=none. This is unsafe, as it disables systemd's process lifecycle management for the service. Please update your service to use a safer KillMode=, such as 'mixed' or 'control-group'. Support for KillMode=none is deprecated and will eventually be removed.
Apr 22 19:30:15 raspberrypi systemd[1]: Queued start job for default target Graphical Interface.
Apr 22 19:30:15 raspberrypi systemd[1]: Created slice system-getty.slice.
Apr 22 19:30:16 raspberrypi systemd[1]: Created slice system-modprobe.slice.
Apr 22 19:30:16 raspberrypi systemd[1]: Created slice system-serial\x2dgetty.slice.
Apr 22 19:30:16 raspberrypi systemd[1]: Created slice system-systemd\x2dfsck.slice.
Apr 22 19:30:16 raspberrypi systemd[1]: Created slice User and Session Slice.
Apr 22 19:30:16 raspberrypi systemd[1]: Started Forward Password Requests to Wall Directory Watch.
Apr 22 19:30:16 raspberrypi systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
Apr 22 19:30:16 raspberrypi systemd[1]: Reached target Slices.
Apr 22 19:30:16 raspberrypi systemd[1]: Reached target Swap.
Apr 22 19:30:16 raspberrypi systemd[1]: Listening on Syslog Socket.
Apr 22 19:30:16 raspberrypi systemd[1]: Listening on fsck to fsckd communication Socket.
Apr 22 19:30:16 raspberrypi systemd[1]: Listening on initctl Compatibility Named Pipe.
Apr 22 19:30:16 raspberrypi systemd[1]: Listening on Journal Audit Socket.
Apr 22 19:30:16 raspberrypi systemd[1]: Listening on Journal Socket (/dev/log).
Apr 22 19:30:16 raspberrypi systemd[1]: Listening on Journal Socket.
Apr 22 19:30:16 raspberrypi systemd[1]: Listening on udev Control Socket.
Apr 22 19:30:16 raspberrypi systemd[1]: Listening on udev Kernel Socket.
Apr 22 19:30:16 raspberrypi systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Apr 22 19:30:16 raspberrypi systemd[1]: Mounting POSIX Message Queue File System...
Apr 22 19:30:16 raspberrypi systemd[1]: Mounting RPC Pipe File System...
Apr 22 19:30:16 raspberrypi systemd[1]: Mounting Kernel Debug File System...
Apr 22 19:30:16 raspberrypi systemd[1]: Mounting Kernel Trace File System...
Apr 22 19:30:16 raspberrypi systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped.
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Restore / save the current clock...
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Set the console keyboard layout...
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Create list of static device nodes for the current kernel...
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Load Kernel Module configfs...
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Load Kernel Module drm...
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Load Kernel Module fuse...
Apr 22 19:30:16 raspberrypi systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Apr 22 19:30:16 raspberrypi systemd[1]: Starting File System Check on Root Device...
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Journal Service...
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Load Kernel Modules...
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Coldplug All udev Devices...
Apr 22 19:30:16 raspberrypi systemd[1]: Mounted POSIX Message Queue File System.
Apr 22 19:30:16 raspberrypi kernel: fuse: init (API version 7.37)
Apr 22 19:30:16 raspberrypi systemd[1]: Mounted RPC Pipe File System.
Apr 22 19:30:16 raspberrypi systemd[1]: Mounted Kernel Debug File System.
Apr 22 19:30:16 raspberrypi systemd[1]: Mounted Kernel Trace File System.
Apr 22 19:30:16 raspberrypi systemd[1]: Finished Restore / save the current clock.
Apr 22 19:30:16 raspberrypi systemd[1]: Finished Create list of static device nodes for the current kernel.
Apr 22 19:30:16 raspberrypi systemd[1]: modprobe@configfs.service: Succeeded.
Apr 22 19:30:16 raspberrypi systemd[1]: Finished Load Kernel Module configfs.
Apr 22 19:30:16 raspberrypi systemd[1]: modprobe@fuse.service: Succeeded.
Apr 22 19:30:16 raspberrypi systemd[1]: Finished Load Kernel Module fuse.
Apr 22 19:30:16 raspberrypi systemd[1]: Mounting FUSE Control File System...
Apr 22 19:30:16 raspberrypi systemd[1]: Mounting Kernel Configuration File System...
Apr 22 19:30:16 raspberrypi kernel: i2c_dev: i2c /dev entries driver
Apr 22 19:30:16 raspberrypi systemd[1]: Started File System Check Daemon to report status.
Apr 22 19:30:16 raspberrypi systemd[1]: Finished Load Kernel Modules.
Apr 22 19:30:16 raspberrypi systemd[1]: modprobe@drm.service: Succeeded.
Apr 22 19:30:16 raspberrypi systemd[1]: Finished Load Kernel Module drm.
Apr 22 19:30:16 raspberrypi systemd[1]: Mounted FUSE Control File System.
Apr 22 19:30:16 raspberrypi systemd[1]: Mounted Kernel Configuration File System.
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Apply Kernel Variables...
Apr 22 19:30:16 raspberrypi systemd[1]: Finished File System Check on Root Device.
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Remount Root and Kernel File Systems...
Apr 22 19:30:16 raspberrypi systemd[1]: Finished Apply Kernel Variables.
Apr 22 19:30:16 raspberrypi systemd-journald[107]: Journal started
Apr 22 19:30:16 raspberrypi systemd-journald[107]: Runtime Journal (/run/log/journal/c60a0f79df204a4a93cf207634486974) is 1.0M, max 8.5M, 7.5M free.
Apr 22 19:30:16 raspberrypi systemd[1]: Started Journal Service.
Apr 22 19:30:14 raspberrypi systemd-modules-load[110]: Failed to find module 'lp'
Apr 22 19:30:14 raspberrypi systemd-modules-load[110]: Failed to find module 'ppdev'
Apr 22 19:30:14 raspberrypi systemd-modules-load[110]: Failed to find module 'parport_pc'
Apr 22 19:30:14 raspberrypi systemd-modules-load[110]: Inserted module 'i2c_dev'
Apr 22 19:30:14 raspberrypi systemd-modules-load[110]: Inserted module 'i2c_bcm2708'
Apr 22 19:30:15 raspberrypi systemd-sysctl[117]: Couldn't write '1' to 'kernel/unprivileged_userns_clone', ignoring: No such file or directory
Apr 22 19:30:16 raspberrypi fake-hwclock[97]: Mon 22 Apr 17:30:13 UTC 2024
Apr 22 19:30:16 raspberrypi systemd-fsck[115]: e2fsck 1.46.2 (28-Feb-2021)
Apr 22 19:30:16 raspberrypi systemd-fsck[115]: rootfs: clean, 127234/1929536 files, 1315440/7725184 blocks
Apr 22 19:30:16 raspberrypi kernel: EXT4-fs (mmcblk0p2): re-mounted. Quota mode: none.
Apr 22 19:30:16 raspberrypi systemd[1]: Finished Remount Root and Kernel File Systems.
Apr 22 19:30:16 raspberrypi systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Flush Journal to Persistent Storage...
Apr 22 19:30:16 raspberrypi systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped.
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Load/Save Random Seed...
Apr 22 19:30:16 raspberrypi systemd[1]: Starting Create System Users...
Apr 22 19:30:16 raspberrypi kernel: Indeed it is in host mode hprt0 = 00021501
Apr 22 19:30:17 raspberrypi kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg
Apr 22 19:30:17 raspberrypi kernel: Indeed it is in host mode hprt0 = 00001101
Apr 22 19:30:17 raspberrypi systemd-journald[107]: Time spent on flushing to /var/log/journal/c60a0f79df204a4a93cf207634486974 is 1.893989s for 293 entries.
Apr 22 19:30:17 raspberrypi systemd-journald[107]: System Journal (/var/log/journal/c60a0f79df204a4a93cf207634486974) is 888.1M, max 2.8G, 2.0G free.
Apr 22 19:30:20 raspberrypi kernel: usb 1-1: New USB device found, idVendor=05c6, idProduct=9025, bcdDevice= 2.28
Apr 22 19:30:20 raspberrypi kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Apr 22 19:30:20 raspberrypi kernel: usb 1-1: Product: Mobile Connect
Apr 22 19:30:20 raspberrypi kernel: usb 1-1: Manufacturer: Mobile Connect
Apr 22 19:30:20 raspberrypi kernel: usb 1-1: SerialNumber: a20df9143703
Apr 22 19:30:20 raspberrypi kernel: usb-storage 1-1:1.5: USB Mass Storage device detected
Apr 22 19:30:20 raspberrypi kernel: scsi host0: usb-storage 1-1:1.5
Apr 22 19:30:20 raspberrypi kernel: scsi 0:0:0:0: Direct-Access              SD Storage       0000 PQ: 0 ANSI: 2
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] Unit Not Ready
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] Sense Key : 0x5 [current] 
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] ASC=0x20 ASCQ=0x0 
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] Read Capacity(10) failed: Result: hostbyte=0x00 driverbyte=DRIVER_OK
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] Sense Key : 0x5 [current] 
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] ASC=0x20 ASCQ=0x0 
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] 0 512-byte logical blocks: (0 B/0 B)
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] 0-byte physical blocks
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] Write Protect is off
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 00 00
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Apr 22 19:30:20 raspberrypi kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk
Apr 22 19:30:20 raspberrypi kernel: scsi 0:0:0:1: CD-ROM                     Mass Storage     0000 PQ: 0 ANSI: 2
Apr 22 19:30:17 raspberrypi systemd[1]: Finished Load/Save Random Seed.
Apr 22 19:30:17 raspberrypi systemd[1]: Condition check resulted in First Boot Complete being skipped.
Apr 22 19:30:17 raspberrypi systemd[1]: Finished Set the console keyboard layout.
Apr 22 19:30:17 raspberrypi systemd[1]: Finished Create System Users.
Apr 22 19:30:17 raspberrypi systemd[1]: Starting Create Static Device Nodes in /dev...
Apr 22 19:30:18 raspberrypi systemd[1]: Finished Coldplug All udev Devices.
Apr 22 19:30:18 raspberrypi systemd[1]: Starting Helper to synchronize boot up for ifupdown...
Apr 22 19:30:18 raspberrypi systemd[1]: Finished Helper to synchronize boot up for ifupdown.
Apr 22 19:30:18 raspberrypi systemd[1]: Finished Create Static Device Nodes in /dev.
Apr 22 19:30:18 raspberrypi systemd[1]: Reached target Local File Systems (Pre).
Apr 22 19:30:18 raspberrypi systemd[1]: Starting Rule-based Manager for Device Events and Files...
Apr 22 19:30:20 raspberrypi systemd[1]: Started Rule-based Manager for Device Events and Files.
Apr 22 19:30:20 raspberrypi systemd[1]: Starting Show Plymouth Boot Screen...
Apr 22 19:30:20 raspberrypi systemd[1]: Received SIGRTMIN+20 from PID 140 (plymouthd).
Apr 22 19:30:20 raspberrypi systemd[1]: Finished Flush Journal to Persistent Storage.
Apr 22 19:30:20 raspberrypi systemd[1]: Started Show Plymouth Boot Screen.
Apr 22 19:30:20 raspberrypi systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Apr 22 19:30:20 raspberrypi systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Apr 22 19:30:20 raspberrypi systemd[1]: Reached target Local Encrypted Volumes.
Apr 22 19:30:21 raspberrypi kernel: usb 1-1: USB disconnect, device number 2
Apr 22 19:30:21 raspberrypi kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Apr 22 19:30:21 raspberrypi kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK
Apr 22 19:30:21 raspberrypi kernel: Indeed it is in host mode hprt0 = 00021501
Apr 22 19:30:21 raspberrypi kernel: usb 1-1: new high-speed USB device number 3 using dwc_otg
Apr 22 19:30:21 raspberrypi kernel: Indeed it is in host mode hprt0 = 00001101
Apr 22 19:30:21 raspberrypi kernel: usb 1-1: New USB device found, idVendor=2001, idProduct=7e46, bcdDevice= 2.28
Apr 22 19:30:21 raspberrypi kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Apr 22 19:30:21 raspberrypi kernel: usb 1-1: Product: Mobile Connect
Apr 22 19:30:21 raspberrypi kernel: usb 1-1: Manufacturer: Mobile Connect
Apr 22 19:30:21 raspberrypi kernel: usb 1-1: SerialNumber: 0123456789ABCDEF
Apr 22 19:30:21 raspberrypi kernel: usb-storage 1-1:1.2: USB Mass Storage device detected
Apr 22 19:30:21 raspberrypi kernel: scsi host0: usb-storage 1-1:1.2
Apr 22 19:30:22 raspberrypi kernel: scsi 0:0:0:0: Direct-Access              SD Storage       0000 PQ: 0 ANSI: 2
Apr 22 19:30:22 raspberrypi kernel: sd 0:0:0:0: [sda] Unit Not Ready
Apr 22 19:30:22 raspberrypi kernel: sd 0:0:0:0: [sda] Sense Key : 0x5 [current] 
Apr 22 19:30:22 raspberrypi kernel: sd 0:0:0:0: [sda] ASC=0x20 ASCQ=0x0 
Apr 22 19:30:22 raspberrypi kernel: sd 0:0:0:0: [sda] Read Capacity(10) failed: Result: hostbyte=0x00 driverbyte=DRIVER_OK
Apr 22 19:30:22 raspberrypi kernel: sd 0:0:0:0: [sda] Sense Key : 0x5 [current] 
Apr 22 19:30:22 raspberrypi kernel: sd 0:0:0:0: [sda] ASC=0x20 ASCQ=0x0 
Apr 22 19:30:23 raspberrypi kernel: sd 0:0:0:0: [sda] 0 512-byte logical blocks: (0 B/0 B)
Apr 22 19:30:23 raspberrypi kernel: sd 0:0:0:0: [sda] 0-byte physical blocks
Apr 22 19:30:23 raspberrypi kernel: sd 0:0:0:0: [sda] Write Protect is off
Apr 22 19:30:23 raspberrypi kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 00 00
Apr 22 19:30:23 raspberrypi kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Apr 22 19:30:23 raspberrypi kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk
Apr 22 19:30:25 raspberrypi kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Apr 22 19:30:25 raspberrypi kernel: mc: Linux media interface: v0.10
Apr 22 19:30:25 raspberrypi mtp-probe[151]: checking bus 1, device 3: "/sys/devices/platform/soc/20980000.usb/usb1/1-1"
Apr 22 19:30:25 raspberrypi kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Apr 22 19:30:25 raspberrypi kernel: [vc_sm_connected_init]: start
Apr 22 19:30:25 raspberrypi kernel: [vc_sm_connected_init]: installed successfully
Apr 22 19:30:25 raspberrypi mtp-probe[151]: bus: 1, device: 3 was not an MTP device
Apr 22 19:30:26 raspberrypi systemd[1]: Found device /dev/ttyAMA0.
Apr 22 19:30:26 raspberrypi kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Apr 22 19:30:27 raspberrypi kernel: videodev: Linux video capture interface: v2.00
Apr 22 19:30:27 raspberrypi systemd[1]: Found device /dev/disk/by-partuuid/dc50bea6-01.
Apr 22 19:30:27 raspberrypi systemd[1]: Starting File System Check on /dev/disk/by-partuuid/dc50bea6-01...
Apr 22 19:30:28 raspberrypi kernel: usbcore: registered new interface driver cdc_wdm
Apr 22 19:30:28 raspberrypi kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Apr 22 19:30:28 raspberrypi kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Apr 22 19:30:28 raspberrypi kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Apr 22 19:30:28 raspberrypi systemd-fsck[184]: fsck.fat 4.2 (2021-01-31)
Apr 22 19:30:28 raspberrypi systemd-fsck[184]: /dev/mmcblk0p1: 423 files, 26460/130554 clusters
Apr 22 19:30:28 raspberrypi systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Apr 22 19:30:28 raspberrypi kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Apr 22 19:30:28 raspberrypi systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Apr 22 19:30:28 raspberrypi systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Apr 22 19:30:28 raspberrypi systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Apr 22 19:30:28 raspberrypi systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped.
Apr 22 19:30:28 raspberrypi systemd[1]: Finished File System Check on /dev/disk/by-partuuid/dc50bea6-01.
Apr 22 19:30:28 raspberrypi kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Apr 22 19:30:28 raspberrypi systemd[1]: Mounting /boot...
Apr 22 19:30:28 raspberrypi kernel: usbcore: registered new interface driver qmi_wwan
Apr 22 19:30:28 raspberrypi kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Apr 22 19:30:28 raspberrypi kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Apr 22 19:30:29 raspberrypi systemd[1]: Mounted /boot.
Apr 22 19:30:29 raspberrypi systemd[1]: Reached target Local File Systems.
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Apr 22 19:30:29 raspberrypi systemd[1]: Starting Set console font and keymap...
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
Apr 22 19:30:29 raspberrypi systemd[1]: Starting Raise network interfaces...
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
Apr 22 19:30:29 raspberrypi systemd[1]: Starting Preprocess NFS configuration...
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Apr 22 19:30:29 raspberrypi systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Apr 22 19:30:29 raspberrypi kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Apr 22 19:30:29 raspberrypi systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped.
Apr 22 19:30:29 raspberrypi systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Apr 22 19:30:29 raspberrypi systemd[1]: Starting Create Volatile Files and Directories...
Apr 22 19:30:29 raspberrypi systemd[1]: Finished Set console font and keymap.
Apr 22 19:30:29 raspberrypi systemd[1]: nfs-config.service: Succeeded.
Apr 22 19:30:29 raspberrypi systemd[1]: Finished Preprocess NFS configuration.
Apr 22 19:30:29 raspberrypi systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Apr 22 19:30:29 raspberrypi systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Apr 22 19:30:29 raspberrypi systemd[1]: Reached target NFS client services.
Apr 22 19:30:29 raspberrypi systemd[1]: Reached target Remote File Systems (Pre).
Apr 22 19:30:29 raspberrypi systemd[1]: Reached target Remote File Systems.
Apr 22 19:30:29 raspberrypi kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Apr 22 19:30:30 raspberrypi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Apr 22 19:30:30 raspberrypi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Apr 22 19:30:30 raspberrypi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Apr 22 19:30:30 raspberrypi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Apr 22 19:30:30 raspberrypi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Apr 22 19:30:30 raspberrypi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Apr 22 19:30:30 raspberrypi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18
Apr 22 19:30:30 raspberrypi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
Apr 22 19:30:30 raspberrypi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31
Apr 22 19:30:30 raspberrypi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image
Apr 22 19:30:30 raspberrypi systemd[1]: Finished Create Volatile Files and Directories.
Apr 22 19:30:30 raspberrypi systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Apr 22 19:30:31 raspberrypi kernel: i2c i2c-11: Added multiplexed i2c bus 0
Apr 22 19:30:31 raspberrypi kernel: i2c i2c-11: Added multiplexed i2c bus 10
Apr 22 19:30:31 raspberrypi systemd[1]: Finished Update UTMP about System Boot/Shutdown.
Apr 22 19:30:31 raspberrypi systemd[1]: Received SIGRTMIN+20 from PID 140 (plymouthd).
Apr 22 19:30:31 raspberrypi systemd[1]: Finished Tell Plymouth To Write Out Runtime Data.
Apr 22 19:30:31 raspberrypi systemd[1]: Reached target System Initialization.
Apr 22 19:30:31 raspberrypi systemd[1]: Started CUPS Scheduler.
Apr 22 19:30:31 raspberrypi systemd[1]: Started Daily apt download activities.
Apr 22 19:30:31 raspberrypi systemd[1]: Started Daily apt upgrade and clean activities.
Apr 22 19:30:31 raspberrypi systemd[1]: Started Periodic ext4 Online Metadata Check for All Filesystems.
Apr 22 19:30:31 raspberrypi systemd[1]: Started Discard unused blocks once a week.
Apr 22 19:30:32 raspberrypi systemd[1]: Started Daily rotation of log files.
Apr 22 19:30:32 raspberrypi systemd[1]: Started Daily man-db regeneration.
Apr 22 19:30:32 raspberrypi systemd[1]: Started Daily Cleanup of Temporary Directories.
Apr 22 19:30:32 raspberrypi systemd[1]: Reached target Paths.
Apr 22 19:30:32 raspberrypi systemd[1]: Reached target Timers.
Apr 22 19:30:32 raspberrypi systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Apr 22 19:30:32 raspberrypi systemd[1]: Listening on CUPS Scheduler.
Apr 22 19:30:32 raspberrypi systemd[1]: Listening on D-Bus System Message Bus Socket.
Apr 22 19:30:32 raspberrypi systemd[1]: Listening on PC/SC Smart Card Daemon Activation Socket.
Apr 22 19:30:32 raspberrypi systemd[1]: Listening on triggerhappy.socket.
Apr 22 19:30:32 raspberrypi systemd[1]: Reached target Sockets.
Apr 22 19:30:32 raspberrypi systemd[1]: Reached target Basic System.
Apr 22 19:30:32 raspberrypi systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Apr 22 19:30:32 raspberrypi systemd[1]: Started Regular background program processing daemon.
Apr 22 19:30:32 raspberrypi cron[252]: (CRON) INFO (pidfile fd = 3)
Apr 22 19:30:32 raspberrypi systemd[1]: Started D-Bus System Message Bus.
Apr 22 19:30:32 raspberrypi cron[252]: (CRON) INFO (Running @reboot jobs)
Apr 22 19:30:32 raspberrypi avahi-daemon[251]: Found user 'avahi' (UID 108) and group 'avahi' (GID 113).
Apr 22 19:30:32 raspberrypi avahi-daemon[251]: Successfully dropped root privileges.
Apr 22 19:30:32 raspberrypi avahi-daemon[251]: avahi-daemon 0.8 starting up.
Apr 22 19:30:32 raspberrypi systemd[1]: Starting dphys-swapfile - set up, mount/unmount, and delete a swap file...
Apr 22 19:30:33 raspberrypi systemd[1]: Starting Remove Stale Online ext4 Metadata Check Snapshots...
Apr 22 19:30:33 raspberrypi systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Apr 22 19:30:33 raspberrypi systemd[1]: Starting Check for glamor...
Apr 22 19:30:33 raspberrypi CRON[254]: pam_unix(cron:session): session opened for user admin(uid=1000) by (uid=0)
Apr 22 19:30:33 raspberrypi systemd[1]: Starting Check for v3d driver...
Apr 22 19:30:33 raspberrypi CRON[264]: (admin) CMD (sleep 60; /usr/bin/python3 /home/admin/Desktop/pipipi/app.py >> $HOME/Desktop/log.log 2>&1 # kuckuck-app-onboot)
Apr 22 19:30:33 raspberrypi systemd[1]: Starting Configure Bluetooth Modems connected by UART...
Apr 22 19:30:33 raspberrypi systemd[1]: Starting Authorization Manager...
Apr 22 19:30:33 raspberrypi dbus-daemon[253]: dbus[253]: Unknown username "geoclue" in message bus configuration file
Apr 22 19:30:33 raspberrypi systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Apr 22 19:30:33 raspberrypi systemd[1]: Starting Network Manager...
Apr 22 19:30:33 raspberrypi systemd[1]: Starting LSB: Switch to ondemand cpu governor (unless shift key is pressed)...
Apr 22 19:30:34 raspberrypi avahi-daemon[251]: Successfully called chroot().
Apr 22 19:30:34 raspberrypi avahi-daemon[251]: Successfully dropped remaining capabilities.
Apr 22 19:30:34 raspberrypi systemd[1]: Starting LSB: rng-tools (Debian variant)...
Apr 22 19:30:34 raspberrypi avahi-daemon[251]: No service file found in /etc/avahi/services.
Apr 22 19:30:34 raspberrypi systemd[1]: Starting Check for Raspberry Pi EEPROM updates...
Apr 22 19:30:34 raspberrypi systemd[1]: Starting System Logging Service...
Apr 22 19:30:34 raspberrypi systemd[1]: Condition check resulted in Turn on SSH if /boot/ssh is present being skipped.
Apr 22 19:30:35 raspberrypi avahi-daemon[251]: Joining mDNS multicast group on interface lo.IPv6 with address ::1.
Apr 22 19:30:35 raspberrypi avahi-daemon[251]: New relevant interface lo.IPv6 for mDNS.
Apr 22 19:30:35 raspberrypi avahi-daemon[251]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1.
Apr 22 19:30:35 raspberrypi avahi-daemon[251]: New relevant interface lo.IPv4 for mDNS.
Apr 22 19:30:35 raspberrypi avahi-daemon[251]: Network interface enumeration completed.
Apr 22 19:30:35 raspberrypi avahi-daemon[251]: Registering new address record for ::1 on lo.*.
Apr 22 19:30:35 raspberrypi avahi-daemon[251]: Registering new address record for 127.0.0.1 on lo.IPv4.
Apr 22 19:30:35 raspberrypi systemd[1]: Starting User Login Management...
Apr 22 19:30:35 raspberrypi systemd[1]: Starting triggerhappy global hotkey daemon...
Apr 22 19:30:35 raspberrypi rpi-eeprom-update[296]: This tool only works with a Raspberry Pi 4
Apr 22 19:30:35 raspberrypi rsyslogd[302]: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd.  [v8.2102.0]
Apr 22 19:30:35 raspberrypi rsyslogd[302]: [origin software="rsyslogd" swVersion="8.2102.0" x-pid="302" x-info="https://www.rsyslog.com"] start
Apr 22 19:30:35 raspberrypi systemd[1]: Starting Disk Manager...
Apr 22 19:30:35 raspberrypi thd[327]: Found socket passed from systemd
Apr 22 19:30:35 raspberrypi systemd[1]: Starting LSB: UUGear Web Interface initialize script...
Apr 22 19:30:35 raspberrypi avahi-daemon[251]: Server startup complete. Host name is raspberrypi.local. Local service cookie is 1456189675.
Apr 22 19:30:36 raspberrypi polkitd[269]: started daemon version 0.105 using authority implementation `local' version `0.105'
Apr 22 19:30:36 raspberrypi systemd[1]: Starting LSB: Witty Pi 4 initialize script...
Apr 22 19:30:36 raspberrypi uwi[340]: Starting UWI server...
Apr 22 19:30:36 raspberrypi systemd[1]: Starting WPA supplicant...
Apr 22 19:30:36 raspberrypi dphys-swapfile[256]: want /var/swap=100MByte, checking existing: keeping it
Apr 22 19:30:36 raspberrypi wittypi[343]: Starting Witty Pi 4 Daemon...
Apr 22 19:30:36 raspberrypi systemd[1]: Started System Logging Service.
Apr 22 19:30:36 raspberrypi systemd[1]: Started triggerhappy global hotkey daemon.
Apr 22 19:30:37 raspberrypi systemd[1]: Finished Raise network interfaces.
Apr 22 19:30:37 raspberrypi systemd[1]: e2scrub_reap.service: Succeeded.
Apr 22 19:30:37 raspberrypi systemd[1]: Finished Remove Stale Online ext4 Metadata Check Snapshots.
Apr 22 19:30:37 raspberrypi systemd[1]: Finished Check for v3d driver.
Apr 22 19:30:37 raspberrypi systemd[1]: Finished Check for Raspberry Pi EEPROM updates.
Apr 22 19:30:37 raspberrypi systemd[1]: Started LSB: UUGear Web Interface initialize script.
Apr 22 19:30:37 raspberrypi kernel: Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k SSFS
Apr 22 19:30:37 raspberrypi wpa_supplicant[344]: Successfully initialized wpa_supplicant
Apr 22 19:30:38 raspberrypi systemd[1]: Finished dphys-swapfile - set up, mount/unmount, and delete a swap file.
Apr 22 19:30:38 raspberrypi udisksd[331]: udisks daemon version 2.9.2 starting
Apr 22 19:30:38 raspberrypi kernel: usbcore: registered new interface driver uas
Apr 22 19:30:39 raspberrypi NetworkManager[278]: <info>  [1713807039.4806] NetworkManager (version 1.30.6) is starting... (for the first time)
Apr 22 19:30:39 raspberrypi NetworkManager[278]: <info>  [1713807039.5313] Read config: /etc/NetworkManager/NetworkManager.conf (lib: no-mac-addr-change.conf)
Apr 22 19:30:39 raspberrypi systemd[1]: Started WPA supplicant.
Apr 22 19:30:39 raspberrypi udisksd[331]: failed to load module mdraid: libbd_mdraid.so.2: cannot open shared object file: No such file or directory
Apr 22 19:30:39 raspberrypi NetworkManager[278]: <info>  [1713807039.8821] bus-manager: acquired D-Bus service "org.freedesktop.NetworkManager"
Apr 22 19:30:39 raspberrypi systemd[1]: Finished Check for glamor.
Apr 22 19:30:39 raspberrypi systemd[1]: Started Authorization Manager.
Apr 22 19:30:40 raspberrypi systemd[1]: Started LSB: Witty Pi 4 initialize script.
Apr 22 19:30:40 raspberrypi systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Apr 22 19:30:40 raspberrypi systemd[1]: Started Network Manager.
Apr 22 19:30:40 raspberrypi udisksd[331]: Failed to load the 'mdraid' libblockdev plugin
Apr 22 19:30:40 raspberrypi systemd[1]: Reached target Network.
Apr 22 19:30:40 raspberrypi NetworkManager[278]: <info>  [1713807040.2484] manager[0xdb5018]: monitoring kernel firmware directory '/lib/firmware'.
Apr 22 19:30:40 raspberrypi NetworkManager[278]: <info>  [1713807040.2623] monitoring ifupdown state file '/run/network/ifstate'.
Apr 22 19:30:40 raspberrypi systemd[1]: Starting Modem Manager...
Apr 22 19:30:40 raspberrypi dbus-daemon[253]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=278 comm="/usr/sbin/NetworkManager --no-daemon ")
Apr 22 19:30:40 raspberrypi systemd[1]: Starting CUPS Scheduler...
Apr 22 19:30:40 raspberrypi systemd[1]: Starting OpenVPN service...
Apr 22 19:30:40 raspberrypi systemd[1]: Starting /etc/rc.local Compatibility...
Apr 22 19:30:40 raspberrypi systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Apr 22 19:30:41 raspberrypi systemd[1]: Starting OpenBSD Secure Shell server...
Apr 22 19:30:41 raspberrypi systemd[1]: Starting Permit User Sessions...
Apr 22 19:30:41 raspberrypi systemd[1]: Started VNC Server in Service Mode daemon.
Apr 22 19:30:41 raspberrypi systemd[1]: Finished OpenVPN service.
Apr 22 19:30:41 raspberrypi systemd[1]: Started /etc/rc.local Compatibility.
Apr 22 19:30:42 raspberrypi systemd-logind[325]: New seat seat0.
Apr 22 19:30:42 raspberrypi systemd[1]: Finished Permit User Sessions.
Apr 22 19:30:43 raspberrypi systemd[1]: Started User Login Management.
Apr 22 19:30:43 raspberrypi systemd[1]: Started CUPS Scheduler.
Apr 22 19:30:43 raspberrypi ModemManager[385]: <info>  ModemManager (version 1.14.12) starting in system bus...
Apr 22 19:30:44 raspberrypi vncserver-x11[395]: ServerManager: Server started
Apr 22 19:30:44 raspberrypi kernel: Bluetooth: Core ver 2.22
Apr 22 19:30:44 raspberrypi kernel: NET: Registered PF_BLUETOOTH protocol family
Apr 22 19:30:44 raspberrypi kernel: Bluetooth: HCI device and connection manager initialized
Apr 22 19:30:44 raspberrypi kernel: Bluetooth: HCI socket layer initialized
Apr 22 19:30:44 raspberrypi kernel: Bluetooth: L2CAP socket layer initialized
Apr 22 19:30:44 raspberrypi kernel: Bluetooth: SCO socket layer initialized
Apr 22 19:30:44 raspberrypi systemd[1]: Started Make remote CUPS printers available locally.
Apr 22 19:30:45 raspberrypi systemd[1]: Starting Light Display Manager...
Apr 22 19:30:45 raspberrypi kernel: Bluetooth: HCI UART driver ver 2.3
Apr 22 19:30:45 raspberrypi kernel: Bluetooth: HCI UART protocol H4 registered
Apr 22 19:30:45 raspberrypi kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered
Apr 22 19:30:45 raspberrypi kernel: Bluetooth: HCI UART protocol Broadcom registered
Apr 22 19:30:45 raspberrypi btuart[354]: bcm43xx_init
Apr 22 19:30:45 raspberrypi btuart[354]: Flash firmware /lib/firmware/brcm/BCM43430A1.raspberrypi,model-zero-w.hcd
Apr 22 19:30:45 raspberrypi btuart[354]: Set BDADDR UART: b8:27:eb:7c:62:f9
Apr 22 19:30:45 raspberrypi btuart[354]: Set Controller UART speed to 460800 bit/s
Apr 22 19:30:45 raspberrypi btuart[354]: Device setup complete
Apr 22 19:30:45 raspberrypi systemd[1]: Starting Hold until boot process finishes up...
Apr 22 19:30:45 raspberrypi systemd[1]: Starting Hostname Service...
Apr 22 19:30:46 raspberrypi systemd[1]: Started Configure Bluetooth Modems connected by UART.
Apr 22 19:30:46 raspberrypi raspi-config[285]: Checking if shift key is held down:
Apr 22 19:30:46 raspberrypi raspi-config[418]: Error opening '/dev/input/event*': No such file or directory
Apr 22 19:30:46 raspberrypi rngd[422]: rngd 2.2 starting up...
Apr 22 19:30:46 raspberrypi raspi-config[285]:  No. Switching to ondemand scaling governor.
Apr 22 19:30:46 raspberrypi rngd[422]: entropy feed to the kernel ready
Apr 22 19:30:46 raspberrypi systemd[1]: Started LSB: Switch to ondemand cpu governor (unless shift key is pressed).
Apr 22 19:30:46 raspberrypi systemd[1]: Started LSB: rng-tools (Debian variant).
Apr 22 19:30:47 raspberrypi systemd[1]: Started Modem Manager.
Apr 22 19:30:47 raspberrypi sshd[405]: Server listening on 0.0.0.0 port 22.
Apr 22 19:30:47 raspberrypi sshd[405]: Server listening on :: port 22.
Apr 22 19:30:47 raspberrypi systemd[1]: Started OpenBSD Secure Shell server.
Apr 22 19:30:47 raspberrypi lightdm[408]: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.Accounts was not provided by any .service files
Apr 22 19:30:47 raspberrypi systemd[1]: Started Disk Manager.
Apr 22 19:30:48 raspberrypi udisksd[331]: Acquired the name org.freedesktop.UDisks2 on the system message bus
Apr 22 19:30:49 raspberrypi vncserver-x11[395]: ConsoleDisplay: Cannot find a running X server on vt1
Apr 22 19:30:50 raspberrypi mtp-probe[438]: checking bus 1, device 3: "/sys/devices/platform/soc/20980000.usb/usb1/1-1"
Apr 22 19:30:50 raspberrypi mtp-probe[438]: bus: 1, device: 3 was not an MTP device
Apr 22 19:30:51 raspberrypi wittypi[346]: Witty Pi daemon (v4.14) is started.
Apr 22 19:30:51 raspberrypi wittypi[346]: Running on Raspberry Pi Zero W Rev 1.1
Apr 22 19:30:51 raspberrypi dbus-daemon[253]: [system] Successfully activated service 'org.freedesktop.hostname1'
Apr 22 19:30:51 raspberrypi systemd[1]: Started Hostname Service.
Apr 22 19:30:51 raspberrypi NetworkManager[278]: <info>  [1713807051.8455] hostname: hostname: using hostnamed
Apr 22 19:30:51 raspberrypi NetworkManager[278]: <info>  [1713807051.8498] hostname: hostname changed from (none) to "raspberrypi"
Apr 22 19:30:51 raspberrypi NetworkManager[278]: <info>  [1713807051.8612] dns-mgr[0xdaf8d8]: init: dns=default,systemd-resolved rc-manager=resolvconf (auto)
Apr 22 19:30:52 raspberrypi wittypi[446]: cat: /home/admin/Desktop/pipipi/wittypi/tmp/BUILD-DATA: No such file or directory
Apr 22 19:30:52 raspberrypi systemd[1]: home-admin-Desktop-kuckuck\x2dpi-wittypi-tmp.mount: Succeeded.
Apr 22 19:30:52 raspberrypi NetworkManager[278]: <info>  [1713807052.6672] manager[0xdb5018]: rfkill: Wi-Fi hardware radio set disabled
Apr 22 19:30:52 raspberrypi NetworkManager[278]: <info>  [1713807052.6790] manager[0xdb5018]: rfkill: WWAN hardware radio set enabled
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.0706] Loaded device plugin: NMBluezManager (/usr/lib/arm-linux-gnueabihf/NetworkManager/1.30.6/libnm-device-plugin-bluetooth.so)
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.1041] Loaded device plugin: NMWifiFactory (/usr/lib/arm-linux-gnueabihf/NetworkManager/1.30.6/libnm-device-plugin-wifi.so)
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.1792] Loaded device plugin: NMAtmManager (/usr/lib/arm-linux-gnueabihf/NetworkManager/1.30.6/libnm-device-plugin-adsl.so)
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.3305] Loaded device plugin: NMTeamFactory (/usr/lib/arm-linux-gnueabihf/NetworkManager/1.30.6/libnm-device-plugin-team.so)
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.3546] Loaded device plugin: NMWwanFactory (/usr/lib/arm-linux-gnueabihf/NetworkManager/1.30.6/libnm-device-plugin-wwan.so)
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.4094] manager: rfkill: Wi-Fi enabled by radio killswitch; disabled by state file
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.4446] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.4692] manager: Networking is enabled by state file
Apr 22 19:30:53 raspberrypi dbus-daemon[253]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.5' (uid=0 pid=278 comm="/usr/sbin/NetworkManager --no-daemon ")
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.4950] dhcp-init: Using DHCP client 'internal'
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.5277] settings: Loaded settings plugin: ifupdown ("/usr/lib/arm-linux-gnueabihf/NetworkManager/1.30.6/libnm-settings-plugin-ifupdown.so")
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.5590] settings: Loaded settings plugin: keyfile (internal)
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.5623] ifupdown: management mode: unmanaged
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.5653] ifupdown:       interface-parser: parsing file /etc/network/interfaces
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.5658] ifupdown:       interface-parser: source line includes interfaces file(s) /etc/network/interfaces.d/*
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <warn>  [1713807053.5663] ifupdown: interfaces file /etc/network/interfaces.d/* doesn't exist
Apr 22 19:30:53 raspberrypi NetworkManager[278]: <info>  [1713807053.5666] ifupdown:       interface-parser: finished parsing file /etc/network/interfaces
Apr 22 19:30:53 raspberrypi systemd[1]: Starting Network Manager Script Dispatcher Service...
Apr 22 19:30:53 raspberrypi wittypi[346]: Seems RTC has good time, write RTC time into system
Apr 22 19:30:53 raspberrypi wittypi[346]:   Writing RTC time to system...
Apr 22 19:30:54 raspberrypi systemd[1]: Received SIGRTMIN+21 from PID 140 (plymouthd).
Apr 22 19:30:54 raspberrypi NetworkManager[278]: <info>  [1713807054.1685] device (lo): carrier: link connected
Apr 22 19:30:54 raspberrypi systemd[1]: Received SIGRTMIN+21 from PID 140 (plymouthd).
Apr 22 19:30:54 raspberrypi NetworkManager[278]: <info>  [1713807054.2147] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1)
Apr 22 19:30:54 raspberrypi systemd[1]: Finished Hold until boot process finishes up.
Apr 22 19:30:54 raspberrypi dbus-daemon[253]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Apr 22 19:30:54 raspberrypi kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Apr 22 19:30:54 raspberrypi systemd[1]: Started Getty on tty1.
Apr 22 19:30:54 raspberrypi systemd[1]: Started Serial Getty on ttyAMA0.
Apr 22 19:30:54 raspberrypi systemd[1]: Reached target Login Prompts.
Apr 22 19:30:54 raspberrypi systemd[1]: Reached target Multi-User System.
Apr 22 19:30:55 raspberrypi systemd[1]: Started Network Manager Script Dispatcher Service.
Apr 22 19:30:55 raspberrypi systemd[1]: Started Light Display Manager.
Apr 22 19:30:55 raspberrypi systemd[1]: Reached target Graphical Interface.
Apr 22 19:30:55 raspberrypi NetworkManager[278]: <info>  [1713807055.1309] manager: startup complete
Apr 22 19:30:55 raspberrypi systemd[1]: Starting Update UTMP about System Runlevel Changes...
Apr 22 19:30:55 raspberrypi NetworkManager[278]: <info>  [1713807055.2673] modem-manager: ModemManager available
Apr 22 19:30:55 raspberrypi kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Apr 22 19:30:55 raspberrypi kernel: cfg80211: loaded regulatory.db is malformed or signature is missing/invalid
Apr 22 19:30:55 raspberrypi systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Apr 22 19:30:55 raspberrypi systemd[1]: Finished Update UTMP about System Runlevel Changes.
Apr 22 19:30:55 raspberrypi systemd[1]: Startup finished in 4.441s (kernel) + 47.320s (userspace) = 51.761s.
Apr 22 19:30:56 raspberrypi vncserver-x11[395]: ConsoleDisplay: Found running X server (pid=484, binary=/usr/lib/xorg/Xorg)
Apr 22 19:30:56 raspberrypi sudo[507]:     root : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-ntp 0
Apr 22 19:30:56 raspberrypi sudo[507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 22 19:30:56 raspberrypi login[485]: pam_unix(login:session): session opened for user admin(uid=1000) by LOGIN(uid=0)
Apr 22 19:30:56 raspberrypi dbus-daemon[253]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.16' (uid=0 pid=509 comm="timedatectl set-ntp 0 ")
Apr 22 19:30:57 raspberrypi systemd[1]: Starting Time & Date Service...
Apr 22 19:30:57 raspberrypi vncserver-x11[395]: AgentInitCheck: agent comms failure
Apr 22 19:30:57 raspberrypi systemd[1]: Created slice User Slice of UID 1000.
Apr 22 19:30:57 raspberrypi systemd[1]: Starting User Runtime Directory /run/user/1000...
Apr 22 19:30:57 raspberrypi systemd-logind[325]: New session 2 of user admin.
Apr 22 19:30:58 raspberrypi systemd[1]: Finished User Runtime Directory /run/user/1000.
Apr 22 19:30:58 raspberrypi systemd[1]: Starting User Manager for UID 1000...
Apr 22 19:30:58 raspberrypi systemd[1]: systemd-fsckd.service: Succeeded.
Apr 22 19:30:58 raspberrypi systemd[519]: pam_unix(systemd-user:session): session opened for user admin(uid=1000) by (uid=0)
Apr 22 19:30:59 raspberrypi kernel: Console: switching to colour dummy device 80x30
Apr 22 19:30:59 raspberrypi kernel: vc4-drm soc:gpu: bound 20400000.hvs (ops vc4_hvs_ops [vc4])
Apr 22 19:31:00 raspberrypi kernel: Registered IR keymap rc-cec
Apr 22 19:31:00 raspberrypi kernel: rc rc0: vc4-hdmi as /devices/platform/soc/20902000.hdmi/rc/rc0
Apr 22 19:31:00 raspberrypi kernel: input: vc4-hdmi as /devices/platform/soc/20902000.hdmi/rc/rc0/input0
Apr 22 19:31:00 raspberrypi kernel: vc4-drm soc:gpu: bound 20902000.hdmi (ops vc4_hdmi_ops [vc4])
Apr 22 19:31:00 raspberrypi kernel: vc4-drm soc:gpu: bound 20004000.txp (ops vc4_txp_ops [vc4])
Apr 22 19:31:00 raspberrypi kernel: vc4-drm soc:gpu: bound 20206000.pixelvalve (ops vc4_crtc_ops [vc4])
Apr 22 19:31:00 raspberrypi kernel: vc4-drm soc:gpu: bound 20207000.pixelvalve (ops vc4_crtc_ops [vc4])
Apr 22 19:31:00 raspberrypi kernel: vc4-drm soc:gpu: bound 20807000.pixelvalve (ops vc4_crtc_ops [vc4])
Apr 22 19:31:00 raspberrypi kernel: vc4-drm soc:gpu: bound 20c00000.v3d (ops vc4_v3d_ops [vc4])
Apr 22 19:31:00 raspberrypi dbus-daemon[253]: [system] Successfully activated service 'org.freedesktop.timedate1'
Apr 22 19:31:00 raspberrypi systemd[1]: Started Time & Date Service.
Apr 22 19:31:00 raspberrypi kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6
Apr 22 19:31:00 raspberrypi kernel: [drm] Initialized vc4 0.0.0 20140616 for soc:gpu on minor 0
Apr 22 19:31:00 raspberrypi kernel: vc4-drm soc:gpu: [drm] Cannot find any crtc or sizes
Apr 22 19:31:01 raspberrypi kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
Apr 22 19:31:01 raspberrypi kernel: usbcore: registered new interface driver brcmfmac
Apr 22 19:31:01 raspberrypi vncserver-x11[395]: ConsoleDisplay: Cannot find a running X server on vt7
Apr 22 19:31:01 raspberrypi kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Jul 19 2021 03:24:18 version 7.45.98 (TOB) (56df937 CY) FWID 01-8e14b897
Apr 22 19:31:01 raspberrypi NetworkManager[278]: <info>  [1713807061.4632] device (wlan0): driver supports Access Point (AP) mode
Apr 22 19:31:01 raspberrypi systemd-timedated[516]: Set NTP to disabled.
Apr 22 19:31:01 raspberrypi NetworkManager[278]: <info>  [1713807061.5881] manager: (wlan0): new 802.11 Wi-Fi device (/org/freedesktop/NetworkManager/Devices/2)
Apr 22 19:31:01 raspberrypi sudo[507]: pam_unix(sudo:session): session closed for user root
Apr 22 19:31:01 raspberrypi vncserver-x11[395]: AgentInitCheck: no response from agent
Apr 22 19:31:01 raspberrypi kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Apr 22 19:31:02 raspberrypi sudo[551]:     root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s @1713854806
Apr 22 19:31:02 raspberrypi sudo[551]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 23 08:46:46 raspberrypi sudo[551]: pam_unix(sudo:session): session closed for user root
Apr 23 08:46:46 raspberrypi wittypi[346]:   Done :-)
Apr 23 08:46:46 raspberrypi wittypi[346]: Firmware ID: 0x02
Apr 23 08:46:46 raspberrypi wittypi[346]: Firmware Revison: 0x05
Apr 23 08:46:47 raspberrypi systemd[1]: Starting Rotate log files...
Apr 23 08:46:47 raspberrypi systemd[1]: Starting Daily man-db regeneration...
Apr 23 08:46:48 raspberrypi wittypi[346]: Current Vin=11.9V, Vout=5.08V, Iout=0.19A
Apr 23 08:46:48 raspberrypi systemd[1]: NetworkManager-dispatcher.service: Succeeded.
Apr 23 08:46:49 raspberrypi vncserver-x11[395]: ConsoleDisplay: Found running X server (pid=548, binary=/usr/lib/xorg/Xorg)
Apr 23 08:46:50 raspberrypi systemd[519]: Queued start job for default target Main User Target.
Apr 23 08:46:50 raspberrypi systemd[519]: Created slice User Application Slice.
Apr 23 08:46:50 raspberrypi systemd[519]: Reached target Paths.
Apr 23 08:46:50 raspberrypi systemd[519]: Reached target Timers.
Apr 23 08:46:50 raspberrypi systemd[519]: Starting D-Bus User Message Bus Socket.
Apr 23 08:46:50 raspberrypi systemd[519]: Listening on GnuPG network certificate management daemon.
Apr 23 08:46:50 raspberrypi systemd[519]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Apr 23 08:46:50 raspberrypi systemd[519]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Apr 23 08:46:50 raspberrypi systemd[519]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Apr 23 08:46:50 raspberrypi systemd[519]: Listening on GnuPG cryptographic agent and passphrase cache.
Apr 23 08:46:50 raspberrypi systemd[519]: Listening on Multimedia System.
Apr 23 08:46:50 raspberrypi systemd[519]: Listening on debconf communication socket.
Apr 23 08:46:50 raspberrypi systemd[519]: Listening on Sound System.
Apr 23 08:46:51 raspberrypi wittypi[346]: System starts up because of the scheduled startup got delayed.
Apr 23 08:46:51 raspberrypi systemd[519]: Listening on D-Bus User Message Bus Socket.
Apr 23 08:46:51 raspberrypi systemd[519]: Reached target Sockets.
Apr 23 08:46:51 raspberrypi systemd[519]: Reached target Basic System.
Apr 23 08:46:51 raspberrypi systemd[1]: Started User Manager for UID 1000.
Apr 23 08:46:51 raspberrypi wittypi[346]: Maybe the scheduled startup was due when Pi was running, or Pi had been shut down but TXD stayed HIGH to prevent the power cut.
Apr 23 08:46:51 raspberrypi systemd[1]: Started Session 2 of user admin.
Apr 23 08:46:51 raspberrypi systemd[519]: Started Multimedia Service.
Apr 23 08:46:51 raspberrypi systemd[519]: Starting Sound Service...
Apr 23 08:46:52 raspberrypi dbus-daemon[253]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.26' (uid=1000 pid=621 comm="/usr/bin/pipewire ")
Apr 23 08:46:52 raspberrypi systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Apr 23 08:46:53 raspberrypi dbus-daemon[253]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Apr 23 08:46:53 raspberrypi rtkit-daemon[634]: Successfully called chroot.
Apr 23 08:46:53 raspberrypi rtkit-daemon[634]: Successfully dropped privileges.
Apr 23 08:46:53 raspberrypi rtkit-daemon[634]: Successfully limited resources.
Apr 23 08:46:53 raspberrypi rtkit-daemon[634]: Running.
Apr 23 08:46:53 raspberrypi systemd[1]: Started RealtimeKit Scheduling Policy Service.
Apr 23 08:46:53 raspberrypi rtkit-daemon[634]: Canary thread running.
Apr 23 08:46:53 raspberrypi rtkit-daemon[634]: Watchdog thread running.
Apr 23 08:46:54 raspberrypi systemd[1]: Stopping Make remote CUPS printers available locally...
Apr 23 08:46:54 raspberrypi systemd[1]: cups-browsed.service: Succeeded.
Apr 23 08:46:54 raspberrypi systemd[1]: Stopped Make remote CUPS printers available locally.
Apr 23 08:46:55 raspberrypi systemd[1]: Stopping CUPS Scheduler...
Apr 23 08:46:55 raspberrypi systemd[1]: cups.service: Succeeded.
Apr 23 08:46:55 raspberrypi systemd[1]: Stopped CUPS Scheduler.
Apr 23 08:46:55 raspberrypi systemd[1]: cups.path: Succeeded.
Apr 23 08:46:55 raspberrypi systemd[1]: Stopped CUPS Scheduler.
Apr 23 08:46:55 raspberrypi systemd[1]: Stopping CUPS Scheduler.
Apr 23 08:46:55 raspberrypi systemd[1]: Started CUPS Scheduler.
Apr 23 08:46:55 raspberrypi systemd[1]: cups.socket: Succeeded.
Apr 23 08:46:55 raspberrypi systemd[1]: Closed CUPS Scheduler.
Apr 23 08:46:55 raspberrypi systemd[1]: Stopping CUPS Scheduler.
Apr 23 08:46:55 raspberrypi systemd[1]: Listening on CUPS Scheduler.
Apr 23 08:46:55 raspberrypi vncserver-x11[395]: AgentInitCheck: no response from agent
Apr 23 08:46:55 raspberrypi systemd[1]: Starting CUPS Scheduler...
Apr 23 08:46:56 raspberrypi systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Apr 23 08:46:56 raspberrypi systemd[1]: Starting Load/Save RF Kill Switch Status...
Apr 23 08:46:56 raspberrypi rtkit-daemon[634]: Successfully made thread 621 of process 621 owned by '1000' high priority at nice level -11.
Apr 23 08:46:56 raspberrypi rtkit-daemon[634]: Supervising 1 threads of 1 processes of 1 users.
Apr 23 08:46:56 raspberrypi rtkit-daemon[634]: Successfully made thread 623 of process 623 owned by '1000' high priority at nice level -11.
Apr 23 08:46:56 raspberrypi rtkit-daemon[634]: Supervising 2 threads of 2 processes of 1 users.
Apr 23 08:46:56 raspberrypi rtkit-daemon[634]: Supervising 2 threads of 2 processes of 1 users.
Apr 23 08:46:56 raspberrypi systemd[519]: Started D-Bus User Message Bus.
Apr 23 08:46:56 raspberrypi rtkit-daemon[634]: Supervising 2 threads of 2 processes of 1 users.
Apr 23 08:46:57 raspberrypi systemd[1]: Started CUPS Scheduler.
Apr 23 08:46:57 raspberrypi rtkit-daemon[634]: Successfully made thread 630 of process 621 owned by '1000' RT at priority 20.
Apr 23 08:46:57 raspberrypi rtkit-daemon[634]: Supervising 3 threads of 2 processes of 1 users.
Apr 23 08:46:57 raspberrypi systemd[1]: logrotate.service: Succeeded.
Apr 23 08:46:57 raspberrypi systemd[1]: Finished Rotate log files.
Apr 23 08:46:57 raspberrypi systemd[1]: Started Make remote CUPS printers available locally.
Apr 23 08:46:57 raspberrypi pipewire[621]: Failed to receive portal pid: org.freedesktop.DBus.Error.NameHasNoOwner: Could not get PID of name 'org.freedesktop.portal.Desktop': no such name
Apr 23 08:46:58 raspberrypi dbus-daemon[253]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.30' (uid=1000 pid=623 comm="/usr/bin/pulseaudio --daemonize=no --log-target=jo")
Apr 23 08:46:58 raspberrypi systemd[1]: Starting Bluetooth service...
Apr 23 08:46:58 raspberrypi rtkit-daemon[634]: Supervising 3 threads of 2 processes of 1 users.
Apr 23 08:46:58 raspberrypi rtkit-daemon[634]: Successfully made thread 688 of process 623 owned by '1000' RT at priority 5.
Apr 23 08:46:58 raspberrypi rtkit-daemon[634]: Supervising 4 threads of 2 processes of 1 users.
Apr 23 08:46:58 raspberrypi rtkit-daemon[634]: Successfully made thread 685 of process 685 owned by '1000' high priority at nice level -11.
Apr 23 08:46:58 raspberrypi rtkit-daemon[634]: Supervising 5 threads of 3 processes of 1 users.
Apr 23 08:46:58 raspberrypi rtkit-daemon[634]: Supervising 5 threads of 3 processes of 1 users.
Apr 23 08:46:59 raspberrypi rtkit-daemon[634]: Supervising 5 threads of 3 processes of 1 users.
Apr 23 08:46:59 raspberrypi systemd[519]: Started Sound Service.
Apr 23 08:46:59 raspberrypi systemd[519]: Reached target Main User Target.
Apr 23 08:46:59 raspberrypi rtkit-daemon[634]: Successfully made thread 689 of process 685 owned by '1000' RT at priority 20.
Apr 23 08:46:59 raspberrypi systemd[519]: Startup finished in 16.326s.
Apr 23 08:46:59 raspberrypi rtkit-daemon[634]: Supervising 6 threads of 3 processes of 1 users.
Apr 23 08:47:00 raspberrypi bluetoothd[687]: Bluetooth daemon 5.55
Apr 23 08:47:00 raspberrypi dbus-daemon[253]: [system] Successfully activated service 'org.bluez'
Apr 23 08:47:00 raspberrypi systemd[1]: Started Bluetooth service.
Apr 23 08:47:00 raspberrypi mtp-probe[698]: checking bus 1, device 3: "/sys/devices/platform/soc/20980000.usb/usb1/1-1"
Apr 23 08:47:00 raspberrypi mtp-probe[698]: bus: 1, device: 3 was not an MTP device
Apr 23 08:47:00 raspberrypi bluetoothd[687]: Starting SDP server
Apr 23 08:47:01 raspberrypi kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Apr 23 08:47:01 raspberrypi kernel: Bluetooth: BNEP filters: protocol multicast
Apr 23 08:47:01 raspberrypi kernel: Bluetooth: BNEP socket layer initialized
Apr 23 08:47:01 raspberrypi bluetoothd[687]: Bluetooth management interface 1.22 initialized
Apr 23 08:47:01 raspberrypi kernel: Bluetooth: MGMT ver 1.22
Apr 23 08:47:01 raspberrypi kernel: NET: Registered PF_ALG protocol family
Apr 23 08:47:01 raspberrypi wittypi[346]: Send out the SYS_UP signal via GPIO-17 pin.
Apr 23 08:47:02 raspberrypi systemd[519]: Reached target Bluetooth.
Apr 23 08:47:02 raspberrypi systemd[1]: Created slice system-bthelper.slice.
Apr 23 08:47:02 raspberrypi systemd[1]: Reached target Bluetooth.
Apr 23 08:47:02 raspberrypi systemd[1]: Starting Raspberry Pi bluetooth helper...
Apr 23 08:47:03 raspberrypi bluetoothd[687]: profiles/sap/server.c:sap_server_register() Sap driver initialization failed.
Apr 23 08:47:03 raspberrypi bluetoothd[687]: sap-server: Operation not permitted (1)
Apr 23 08:47:03 raspberrypi bluetoothd[687]: Endpoint registered: sender=:1.30 path=/MediaEndpoint/A2DPSink/sbc
Apr 23 08:47:03 raspberrypi bluetoothd[687]: Endpoint registered: sender=:1.30 path=/MediaEndpoint/A2DPSource/sbc
Apr 23 08:47:03 raspberrypi pulseaudio[623]: Found duplicated D-Bus path for adapter /org/bluez/hci0
Apr 23 08:47:03 raspberrypi kernel: usbcore: registered new interface driver cdc_ether
Apr 23 08:47:03 raspberrypi bthelper[726]: Raspberry Pi BDADDR already set
Apr 23 08:47:03 raspberrypi systemd[1]: Finished Raspberry Pi bluetooth helper.
Apr 23 08:47:03 raspberrypi kernel: Bluetooth: RFCOMM TTY layer initialized
Apr 23 08:47:03 raspberrypi kernel: Bluetooth: RFCOMM socket layer initialized
Apr 23 08:47:03 raspberrypi kernel: Bluetooth: RFCOMM ver 1.11
Apr 23 08:47:04 raspberrypi bluetoothd[687]: Failed to set privacy: Rejected (0x0b)
Apr 23 08:47:04 raspberrypi wittypi[346]: Pending for incoming shutdown command...
Apr 23 08:47:04 raspberrypi kernel: rndis_host 1-1:1.0 usb0: register 'rndis_host' at usb-20980000.usb-1, RNDIS device, 9a:30:17:31:9c:a5
Apr 23 08:47:04 raspberrypi kernel: usbcore: registered new interface driver rndis_host
Apr 23 08:47:04 raspberrypi NetworkManager[278]: <info>  [1713854824.8177] manager: (usb0): new Ethernet device (/org/freedesktop/NetworkManager/Devices/3)
Apr 23 08:47:06 raspberrypi lightdm[768]: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.Accounts was not provided by any .service files
Apr 23 08:47:06 raspberrypi lightdm[768]: pam_unix(lightdm-autologin:session): session opened for user admin(uid=1000) by (uid=0)
Apr 23 08:47:06 raspberrypi systemd-logind[325]: New session 4 of user admin.
Apr 23 08:47:06 raspberrypi systemd[1]: Started Session 4 of user admin.
Apr 23 08:47:08 raspberrypi systemd-udevd[146]: Using default interface naming scheme 'v247'.
Apr 23 08:47:09 raspberrypi bthelper[793]: Changing power off succeeded
Apr 23 08:47:09 raspberrypi mtp-probe[791]: checking bus 1, device 3: "/sys/devices/platform/soc/20980000.usb/usb1/1-1"
Apr 23 08:47:10 raspberrypi mtp-probe[791]: bus: 1, device: 3 was not an MTP device
Apr 23 08:47:10 raspberrypi bthelper[755]: [56B blob data]
Apr 23 08:47:10 raspberrypi bthelper[755]: Changing power on succeeded
Apr 23 08:47:10 raspberrypi systemd[1]: Started Load/Save RF Kill Switch Status.
Apr 23 08:47:10 raspberrypi NetworkManager[278]: <info>  [1713854830.9119] rfkill1: found Wi-Fi radio killswitch (at /sys/devices/platform/soc/20300000.mmcnr/mmc_host/mmc1/mmc1:0001/mmc1:0001:1/ieee80211/phy0/rfkill1) (driver brcmfmac)
Apr 23 08:47:10 raspberrypi NetworkManager[278]: <info>  [1713854830.9400] manager: rfkill: Wi-Fi now disabled by radio killswitch
Apr 23 08:47:11 raspberrypi kernel: imx477 10-001a: Device found is imx477
Apr 23 08:47:11 raspberrypi kernel: imx477 10-001a: Consider updating driver imx477 to match on endpoints
Apr 23 08:47:12 raspberrypi systemd-udevd[147]: Using default interface naming scheme 'v247'.
Apr 23 08:47:13 raspberrypi systemd-udevd[137]: event0: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 23 08:47:13 raspberrypi systemd-logind[325]: Watching system buttons on /dev/input/event0 (vc4-hdmi)
Apr 23 08:47:13 raspberrypi systemd-udevd[143]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:14 raspberrypi systemd[1]: man-db.service: Succeeded.
Apr 23 08:47:14 raspberrypi systemd[1]: Finished Daily man-db regeneration.
Apr 23 08:47:14 raspberrypi systemd[1]: man-db.service: Consumed 3.987s CPU time.
Apr 23 08:47:15 raspberrypi NetworkManager[278]: <info>  [1713854835.5436] device (wlan0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Apr 23 08:47:15 raspberrypi NetworkManager[278]: <info>  [1713854835.6958] device (wlan0): set-hw-addr: set MAC address to 7E:A8:CF:30:BE:C8 (scanning)
Apr 23 08:47:15 raspberrypi systemd[1]: systemd-rfkill.service: Succeeded.
Apr 23 08:47:15 raspberrypi systemd[1]: systemd-timedated.service: Succeeded.
Apr 23 08:47:16 raspberrypi dbus-daemon[253]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.5' (uid=0 pid=278 comm="/usr/sbin/NetworkManager --no-daemon ")
Apr 23 08:47:16 raspberrypi systemd[519]: Reached target Sound Card.
Apr 23 08:47:16 raspberrypi systemd[1]: Starting Network Manager Script Dispatcher Service...
Apr 23 08:47:16 raspberrypi systemd[1]: Condition check resulted in Manage Sound Card State (restore and store) being skipped.
Apr 23 08:47:16 raspberrypi systemd[1]: Starting Save/Restore Sound Card State...
Apr 23 08:47:17 raspberrypi dbus-daemon[253]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Apr 23 08:47:17 raspberrypi systemd[1]: Started Network Manager Script Dispatcher Service.
Apr 23 08:47:17 raspberrypi ModemManager[385]: <info>  [base-manager] couldn't check support for device '/sys/devices/platform/soc/20300000.mmcnr/mmc_host/mmc1/mmc1:0001/mmc1:0001:1': not supported by any plugin
Apr 23 08:47:18 raspberrypi NetworkManager[278]: <info>  [1713854838.0647] device (usb0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Apr 23 08:47:18 raspberrypi NetworkManager[278]: <info>  [1713854838.2417] device (usb0): carrier: link connected
Apr 23 08:47:18 raspberrypi systemd-udevd[143]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:18 raspberrypi systemd[1]: Finished Save/Restore Sound Card State.
Apr 23 08:47:18 raspberrypi systemd[1]: Reached target Sound Card.
Apr 23 08:47:18 raspberrypi NetworkManager[278]: <info>  [1713854838.9147] device (usb0): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
Apr 23 08:47:19 raspberrypi NetworkManager[278]: <info>  [1713854839.1099] policy: auto-activating connection 'usb0' (3e6312c1-f366-448d-b9a5-56ad555c9698)
Apr 23 08:47:19 raspberrypi NetworkManager[278]: <info>  [1713854839.2596] device (usb0): Activation: starting connection 'usb0' (3e6312c1-f366-448d-b9a5-56ad555c9698)
Apr 23 08:47:19 raspberrypi NetworkManager[278]: <info>  [1713854839.3009] device (usb0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Apr 23 08:47:19 raspberrypi NetworkManager[278]: <info>  [1713854839.4791] manager: NetworkManager state is now CONNECTING
Apr 23 08:47:19 raspberrypi NetworkManager[278]: <info>  [1713854839.5861] device (usb0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Apr 23 08:47:19 raspberrypi NetworkManager[278]: <info>  [1713854839.7617] device (usb0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Apr 23 08:47:19 raspberrypi NetworkManager[278]: <info>  [1713854839.8720] dhcp4 (usb0): activation: beginning transaction (timeout in 45 seconds)
Apr 23 08:47:19 raspberrypi avahi-daemon[251]: Joining mDNS multicast group on interface usb0.IPv6 with address fe80::2d94:8105:d089:bac3.
Apr 23 08:47:19 raspberrypi avahi-daemon[251]: New relevant interface usb0.IPv6 for mDNS.
Apr 23 08:47:19 raspberrypi avahi-daemon[251]: Registering new address record for fe80::2d94:8105:d089:bac3 on usb0.*.
Apr 23 08:47:20 raspberrypi NetworkManager[278]: <info>  [1713854840.2183] dhcp4 (usb0): state changed unknown -> bound, address=192.168.0.33
Apr 23 08:47:20 raspberrypi systemd-udevd[144]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:20 raspberrypi avahi-daemon[251]: Joining mDNS multicast group on interface usb0.IPv4 with address 192.168.0.33.
Apr 23 08:47:20 raspberrypi avahi-daemon[251]: New relevant interface usb0.IPv4 for mDNS.
Apr 23 08:47:20 raspberrypi avahi-daemon[251]: Registering new address record for 192.168.0.33 on usb0.IPv4.
Apr 23 08:47:20 raspberrypi ModemManager[385]: <info>  [base-manager] couldn't check support for device '/sys/devices/platform/soc/20980000.usb/usb1/1-1': not supported by any plugin
Apr 23 08:47:20 raspberrypi NetworkManager[278]: <info>  [1713854840.4650] device (usb0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Apr 23 08:47:20 raspberrypi NetworkManager[278]: <info>  [1713854840.8367] device (usb0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Apr 23 08:47:20 raspberrypi NetworkManager[278]: <info>  [1713854840.9175] device (usb0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Apr 23 08:47:20 raspberrypi systemd-udevd[144]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:21 raspberrypi NetworkManager[278]: <info>  [1713854841.0938] manager: NetworkManager state is now CONNECTED_LOCAL
Apr 23 08:47:21 raspberrypi NetworkManager[278]: <info>  [1713854841.4358] manager: NetworkManager state is now CONNECTED_SITE
Apr 23 08:47:21 raspberrypi systemd-udevd[144]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:21 raspberrypi NetworkManager[278]: <info>  [1713854841.5189] policy: set 'usb0' (usb0) as default for IPv4 routing and DNS
Apr 23 08:47:21 raspberrypi dbus-daemon[253]: [system] Activating via systemd: service name='org.freedesktop.resolve1' unit='dbus-org.freedesktop.resolve1.service' requested by ':1.5' (uid=0 pid=278 comm="/usr/sbin/NetworkManager --no-daemon ")
Apr 23 08:47:21 raspberrypi dbus-daemon[253]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.resolve1.service': Unit dbus-org.freedesktop.resolve1.service not found.
Apr 23 08:47:21 raspberrypi NetworkManager[278]: <info>  [1713854841.6635] dns-mgr: Writing DNS information to /sbin/resolvconf
Apr 23 08:47:22 raspberrypi systemd-udevd[144]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:23 raspberrypi systemd-udevd[144]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:23 raspberrypi systemd-udevd[144]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:24 raspberrypi systemd-udevd[144]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:24 raspberrypi avahi-daemon[251]: Got SIGHUP, reloading.
Apr 23 08:47:24 raspberrypi avahi-daemon[251]: No service file found in /etc/avahi/services.
Apr 23 08:47:24 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Activating via systemd: service name='org.gtk.vfs.Daemon' unit='gvfs-daemon.service' requested by ':1.6' (uid=1000 pid=781 comm="/usr/bin/lxsession -s LXDE-pi -e LXDE -w openbox-l")
Apr 23 08:47:24 raspberrypi systemd[519]: Starting Virtual filesystem service...
Apr 23 08:47:24 raspberrypi systemd-udevd[144]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:25 raspberrypi NetworkManager[278]: <info>  [1713854845.3458] device (usb0): Activation: successful, device activated.
Apr 23 08:47:25 raspberrypi systemd-udevd[144]: regulatory.0: Process '/lib/crda/crda' failed with exit code 249.
Apr 23 08:47:25 raspberrypi NetworkManager[278]: <info>  [1713854845.5258] manager: NetworkManager state is now CONNECTED_GLOBAL
Apr 23 08:47:25 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Successfully activated service 'org.gtk.vfs.Daemon'
Apr 23 08:47:25 raspberrypi systemd[519]: Started Virtual filesystem service.
Apr 23 08:47:27 raspberrypi pulseaudio[623]: Failed to find a working profile.
Apr 23 08:47:27 raspberrypi pulseaudio[623]: Failed to load module "module-alsa-card" (argument: "device_id="0" name="platform-20902000.hdmi" card_name="alsa_card.platform-20902000.hdmi" namereg_fail=false tsched=no fixed_latency_range=no ignore_dB=no deferred_volume=yes use_ucm=yes avoid_resampling=no card_properties="module-udev-detect.discovered=1""): initialization failed.
Apr 23 08:47:33 raspberrypi polkitd(authority=local)[269]: Registered Authentication Agent for unix-session:4 (system bus name :1.43 [lxpolkit], object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale en_GB.UTF-8)
Apr 23 08:47:33 raspberrypi systemd[1]: systemd-hostnamed.service: Succeeded.
Apr 23 08:47:37 raspberrypi systemd[1]: NetworkManager-dispatcher.service: Succeeded.
Apr 23 08:48:00 raspberrypi /home/admin/Desktop/pipipi/app.py[921]: helpers.system_info(): start
Apr 23 08:48:00 raspberrypi /home/admin/Desktop/pipipi/app.py[921]: helpers.read_voltage(): start
Apr 23 08:48:00 raspberrypi /home/admin/Desktop/pipipi/app.py[921]: WittyPi Voltage: 11.9 Volt
Apr 23 08:48:01 raspberrypi /home/admin/Desktop/pipipi/app.py[921]: Next Witty Startup: 23 09:00:00
Apr 23 08:48:03 raspberrypi sudo[1323]: admin : PWD=/home/admin ; USER=root ; COMMAND=/usr/sbin/shutdown -r +15
Apr 23 08:48:03 raspberrypi sudo[1323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 08:48:04 raspberrypi sudo[1323]: pam_unix(sudo:session): session closed for user root
Apr 23 08:48:04 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Activating via systemd: service name='org.gtk.vfs.UDisks2VolumeMonitor' unit='gvfs-udisks2-volume-monitor.service' requested by ':1.10' (uid=1000 pid=1128 comm="pcmanfm --desktop --profile LXDE-pi ")
Apr 23 08:48:04 raspberrypi systemd[519]: Starting Virtual filesystem service - disk device monitor...
Apr 23 08:48:06 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Successfully activated service 'org.gtk.vfs.UDisks2VolumeMonitor'
Apr 23 08:48:06 raspberrypi systemd[519]: Started Virtual filesystem service - disk device monitor.
Apr 23 08:48:06 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Activating via systemd: service name='org.gtk.vfs.MTPVolumeMonitor' unit='gvfs-mtp-volume-monitor.service' requested by ':1.10' (uid=1000 pid=1128 comm="pcmanfm --desktop --profile LXDE-pi ")
Apr 23 08:48:06 raspberrypi systemd[519]: Starting Virtual filesystem service - Media Transfer Protocol monitor...
Apr 23 08:48:06 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Successfully activated service 'org.gtk.vfs.MTPVolumeMonitor'
Apr 23 08:48:06 raspberrypi systemd[519]: Started Virtual filesystem service - Media Transfer Protocol monitor.
Apr 23 08:48:06 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Activating via systemd: service name='org.gtk.vfs.GoaVolumeMonitor' unit='gvfs-goa-volume-monitor.service' requested by ':1.10' (uid=1000 pid=1128 comm="pcmanfm --desktop --profile LXDE-pi ")
Apr 23 08:48:06 raspberrypi systemd[519]: Starting Virtual filesystem service - GNOME Online Accounts monitor...
Apr 23 08:48:07 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Successfully activated service 'org.gtk.vfs.GoaVolumeMonitor'
Apr 23 08:48:07 raspberrypi systemd[519]: Started Virtual filesystem service - GNOME Online Accounts monitor.
Apr 23 08:48:07 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Activating via systemd: service name='org.gtk.vfs.AfcVolumeMonitor' unit='gvfs-afc-volume-monitor.service' requested by ':1.10' (uid=1000 pid=1128 comm="pcmanfm --desktop --profile LXDE-pi ")
Apr 23 08:48:07 raspberrypi systemd[519]: Starting Virtual filesystem service - Apple File Conduit monitor...
Apr 23 08:48:07 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Successfully activated service 'org.gtk.vfs.AfcVolumeMonitor'
Apr 23 08:48:07 raspberrypi systemd[519]: Started Virtual filesystem service - Apple File Conduit monitor.
Apr 23 08:48:07 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Activating via systemd: service name='org.gtk.vfs.GPhoto2VolumeMonitor' unit='gvfs-gphoto2-volume-monitor.service' requested by ':1.10' (uid=1000 pid=1128 comm="pcmanfm --desktop --profile LXDE-pi ")
Apr 23 08:48:07 raspberrypi systemd[519]: Starting Virtual filesystem service - digital camera monitor...
Apr 23 08:48:08 raspberrypi dbus-daemon[676]: [session uid=1000 pid=676] Successfully activated service 'org.gtk.vfs.GPhoto2VolumeMonitor'
Apr 23 08:48:08 raspberrypi systemd[519]: Started Virtual filesystem service - digital camera monitor.
Apr 23 08:48:13 raspberrypi NetworkManager[278]: <info>  [1713854893.5731] dhcp6 (usb0): activation: beginning transaction (timeout in 45 seconds)
Apr 23 08:48:13 raspberrypi NetworkManager[278]: <info>  [1713854893.7197] policy: set 'usb0' (usb0) as default for IPv6 routing and DNS
Apr 23 08:48:13 raspberrypi avahi-daemon[251]: Leaving mDNS multicast group on interface usb0.IPv6 with address fe80::2d94:8105:d089:bac3.
Apr 23 08:48:13 raspberrypi avahi-daemon[251]: Joining mDNS multicast group on interface usb0.IPv6 with address 2a00:fbc:e17f:c08a:36c:725d:9f6b:7ab8.
Apr 23 08:48:13 raspberrypi NetworkManager[278]: <info>  [1713854893.8660] agent-manager: agent[16264e2a23d24d66,:1.47/org.freedesktop.nm-applet/1000]: agent registered
Apr 23 08:48:13 raspberrypi avahi-daemon[251]: Registering new address record for 2a00:fbc:e17f:c08a:36c:725d:9f6b:7ab8 on usb0.*.
Apr 23 08:48:13 raspberrypi avahi-daemon[251]: Withdrawing address record for fe80::2d94:8105:d089:bac3 on usb0.
Apr 23 08:48:14 raspberrypi NetworkManager[278]: <info>  [1713854894.6240] dhcp6 (usb0): state changed unknown -> bound
Apr 23 08:48:14 raspberrypi NetworkManager[278]: <info>  [1713854894.6830] dns-mgr: Writing DNS information to /sbin/resolvconf
Apr 23 08:48:15 raspberrypi avahi-daemon[251]: Got SIGHUP, reloading.
Apr 23 08:48:15 raspberrypi avahi-daemon[251]: No service file found in /etc/avahi/services.
Apr 23 08:48:15 raspberrypi dbus-daemon[253]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.5' (uid=0 pid=278 comm="/usr/sbin/NetworkManager --no-daemon ")
Apr 23 08:48:16 raspberrypi systemd[1]: Starting Network Manager Script Dispatcher Service...
Apr 23 08:48:16 raspberrypi dbus-daemon[253]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Apr 23 08:48:16 raspberrypi systemd[1]: Started Network Manager Script Dispatcher Service.
Apr 23 08:48:20 raspberrypi dbus-daemon[253]: [system] Activating via systemd: service name='org.freedesktop.PackageKit' unit='packagekit.service' requested by ':1.47' (uid=1000 pid=1114 comm="lxpanel --profile LXDE-pi ")
Apr 23 08:48:20 raspberrypi systemd[1]: Starting PackageKit Daemon...
Apr 23 08:48:20 raspberrypi PackageKit[1525]: daemon start
Apr 23 08:48:23 raspberrypi dbus-daemon[253]: [system] Successfully activated service 'org.freedesktop.PackageKit'
Apr 23 08:48:23 raspberrypi systemd[1]: Started PackageKit Daemon.
Apr 23 08:48:23 raspberrypi PackageKit[1525]: uid 1000 is trying to obtain org.freedesktop.packagekit.system-sources-refresh auth (only_trusted:0)
Apr 23 08:48:23 raspberrypi PackageKit[1525]: uid 1000 obtained auth for org.freedesktop.packagekit.system-sources-refresh
Apr 23 08:48:26 raspberrypi systemd[1]: NetworkManager-dispatcher.service: Succeeded.
Apr 23 08:48:58 raspberrypi PackageKit[1525]: refresh-cache transaction /466_cdadacac from uid 1000 finished with success after 34871ms
Apr 23 08:49:35 raspberrypi PackageKit[1525]: get-updates transaction /467_ccaddceb from uid 1000 finished with success after 36244ms
Apr 23 08:49:53 raspberrypi wittypi[346]: Shutting down system because scheduled shutdown is due.

Posted by: @admin

↑

I also suggested you to schedule the shutdown and startup with much shorter peroid, so you can observe how it behaves in person. But you didn't take my suggestions, did you?

I did. Just didn't happen again so far...