Moode Forum

Moode Forum > moOde audio player > Support > Bootup/shutdown issues, how to debug
Full Version: Bootup/shutdown issues, how to debug
You're currently viewing a stripped down version of our content. View the full version with proper formatting.
Pages: 1 2

Max Schmeling

04-12-2021, 12:27 PM
Having used Moode for some time without issues, I decided to enable bluetooth. After this boot seems to be quite a bit slower, but shutdown seems to take minutes, if it even gets there. I tried to upgrade to the latest version, but with no improvement. I'm assuming, that the issue is bluetooth related, but I'm not sure. How can I debug this issue, and where can I find the logs?

Tim Curtis

04-12-2021, 03:10 PM
Reboot and post the moOde startup log

Code:
moodeutl -l

Max Schmeling

04-12-2021, 03:42 PM
Here goes:


Code:
Last login: Mon Apr 12 17:38:55 2021 from 10.0.0.3
pi@moode:~ $ moodeutl -l
20210412 173546 worker: -- Start
20210412 173546 worker: Successfully daemonized
20210412 173546 worker: Integrity check (passed)
20210412 173547 worker: File check (OK)
20210412 173547 worker: Session vacuumed
20210412 173547 worker: Session loaded
20210412 173547 worker: Debug logging (ON)
20210412 173547 worker: -- Device
20210412 173547 worker: ALSA cards: (0:sndrpirpidac | 1:empty | 2:empty | 3:empty
20210412 173547 worker: MPD config: (0:Audiophonics ES9023 DAC | mixer:(none) | card:0)
20210412 173547 worker: ALSA mixer actual (none)
20210412 173547 worker: ALSA volume (none)
20210412 173547 worker: -- System
20210412 173548 worker: Host     (moode)
20210412 173549 worker: moOde    (7.1.0 2021-03-15)
20210412 173549 worker: RaspiOS  (10.6)
20210412 173549 worker: Kernel   (5.4.77-v7l+ #1371)
20210412 173549 worker: Platform (Pi-4B 1.1 4GB)
20210412 173549 worker: ARM arch (armv7l, 32-bit kernel)
20210412 173549 worker: MPD ver  (0.22.6_p0x3)
20210412 173549 worker: CPU gov  (ondemand)
20210412 173549 worker: USB boot not available
20210412 173549 worker: File system not expanded yet
20210412 173549 worker: HDMI port off
20210412 173549 worker: -- Network
20210412 173549 worker: eth0 exists
20210412 173549 worker: IP addr (10.0.0.50)
20210412 173549 worker: Netmask (255.255.255.0)
20210412 173549 worker: Gateway (10.0.0.1)
20210412 173549 worker: Pri DNS (10.0.0.1)
20210412 173549 worker: Domain  (None)
20210412 173549 worker: wlan0 does not exist
20210412 173549 worker: -- Audio
20210412 173549 worker: MPD conf updated
20210412 173549 worker: ALSA card number (0)
20210412 173549 worker: MPD audio output (Audiophonics ES9023 DAC)
20210412 173549 worker: Audio formats (S16_LE, S24_LE)
20210412 173549 worker: ALSA mixer name (none)
20210412 173549 worker: MPD volume control (software)
20210412 173549 worker: Hdwr volume controller not detected
20210412 173549 worker: Reset renderer active flags
20210412 173549 worker: CamillaDSP (off)
20210412 173549 worker: -- MPD
20210412 173549 worker: MPD started
20210412 173549 openMpdSocket(): error: connection failed (1) 111, Connection refused
20210412 173550 worker: MPD accepting connections
20210412 173550 worker: MPD output 1 ALSA Default (on)
20210412 173550 worker: MPD output 2 ALSA Crossfeed (off)
20210412 173550 worker: MPD output 3 ALSA Parametric EQ (off)
20210412 173550 worker: MPD output 4 ALSA Graphic EQ (off)
20210412 173550 worker: MPD output 5 ALSA Polarity Inv (off)
20210412 173550 worker: MPD output 6 ALSA CamillaDSP (off)
20210412 173550 worker: MPD output 7 ALSA Bluetooth (off)
20210412 173550 worker: MPD output 8 HTTP Server (off)
20210412 173550 worker: MPD crossfade (off)
20210412 173550 worker: MPD ignore CUE files (yes)
20210412 173550 worker: -- Feature availability
20210412 173550 worker: Source select (available)
20210412 173550 worker: Source select (source: MPD)
20210412 173550 worker: Source select (output: Audiophonics ES9023 DAC)
20210412 173557 worker: Bluetooth pairing agent (started)
20210412 173557 worker: Bluetooth (available: started)
20210412 173557 worker: Airplay renderer (available)
20210412 173557 worker: Spotify renderer (available)
20210412 173557 worker: Squeezelite (available)
20210412 173557 worker: RoonBridge renderer (not installed)
20210412 173557 worker: UPnP renderer (available)
20210412 173557 worker: DLNA server (available)
20210412 173557 worker: UPnP browser (available)
20210412 173557 worker: GPIO button handler (available)
20210412 173557 worker: Stream recorder (n/a)
20210412 173557 worker: -- Music sources
20210412 173557 worker: USB sources (none attached)
20210412 173559 sourceMount(): Command=(mount -t cifs "//DISKSTATION/music" -o username="Linnberry",password="moode",rsize=61440,wsize=65536,iocharset=utf8,vers=1.0,ro,dir_mode=0777,file_mode=0777 "/mnt/NAS/Music")
20210412 173559 worker: NAS and UPnP sources (mountall initiated)
20210412 173559 worker: -- Miscellaneous
20210412 173559 worker: USB volume knob (Off)
20210412 173559 worker: USB auto-mounter (udisks-glue)
20210412 173559 worker: LED0 (On)
20210412 173559 worker: LED1 (On)
20210412 173559 worker: Saved MPD vol level (0)
20210412 173559 worker: Preamp volume level (0)
20210412 173559 worker: MPD volume level (6) restored
20210412 173559 worker: ALSA volume level (None)
20210412 173559 worker: Auto-play (Off)
20210412 173559 worker: Maintenance interval (3 hrs)
20210412 173559 worker: Screen saver activation (Never)
20210412 173559 worker: Session permissions (OK)
20210412 173600 worker: Watchdog started
20210412 173600 worker: Ready
pi@moode:~ $

Max Schmeling

04-12-2021, 03:43 PM
Please disregard the resulting autoformat smileys

Tim Curtis

04-12-2021, 03:48 PM
The log indicates moOde startup took ~15 secs.

Code:
20210412 173546 worker: -- Start
20210412 173600 worker: Ready

vinnn

04-12-2021, 03:52 PM
(04-12-2021, 03:43 PM)Max Schmeling Wrote: [ -> ]Please disregard the resulting autoformat smileys

You can avoid this by using a code box

Max Schmeling

04-12-2021, 03:55 PM
(04-12-2021, 03:48 PM)Tim Curtis Wrote: [ -> ]The log indicates moOde startup took ~15 secs.

Code:
20210412 173546 worker: -- Start
20210412 173600 worker: Ready
That is because, I killed the power first. I think it is the shutdown, that creates the problems. The shutdown process hangs sometimes, and the power ends up being cut before moode has completed the shutdown. Sometimes this creates longer startup times, but I think the problem comes from shutting down.

Is there a similar log for shutting down?

Max Schmeling

04-13-2021, 07:30 AM
It seems, the problem is related to shutdown. There is a difference if I use Bluetooth or not. I have done a cat /val/log/messages, that shows at least some of the delay:

First, is just a bootup, playing a file, and then shutting down from the moode GUI:

Code:
Apr 13 08:37:29 moode kernel: [    0.000000] Booting Linux on physical CPU 0x0
Apr 13 08:37:29 moode kernel: [    0.000000] Linux version 5.4.77-v7l+ (dom@buildbot) (gcc version 8.4.0 (Ubuntu/Linaro 8.4.0-3ubuntu1)) #1371 SMP Tue Nov 17 13:35:27 GMT 2020
Apr 13 08:37:29 moode kernel: [    0.000000] CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
Apr 13 08:37:29 moode kernel: [    0.000000] CPU: div instructions available: patching division code
Apr 13 08:37:29 moode kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
Apr 13 08:37:29 moode kernel: [    0.000000] OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.1
Apr 13 08:37:29 moode kernel: [    0.000000] Memory policy: Data cache writealloc
Apr 13 08:37:29 moode kernel: [    0.000000] Reserved memory: created CMA memory pool at 0x000000002ac00000, size 64 MiB
Apr 13 08:37:29 moode kernel: [    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Apr 13 08:37:29 moode kernel: [    0.000000] percpu: Embedded 20 pages/cpu s49804 r8192 d23924 u81920
Apr 13 08:37:29 moode kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1010432
Apr 13 08:37:29 moode kernel: [    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=1920 bcm2708_fb.fbheight=1280 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:44:A8:7F vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  net.ifnames=0 console=ttyS0,115200 console=tty1 root=PARTUUID=067e19d7-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
Apr 13 08:37:29 moode kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Apr 13 08:37:29 moode kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Apr 13 08:37:29 moode kernel: [    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
Apr 13 08:37:29 moode kernel: [    0.000000] software IO TLB: mapped [mem 0x23cc0000-0x27cc0000] (64MB)
Apr 13 08:37:29 moode kernel: [    0.000000] Memory: 3852596K/4050944K available (10240K kernel code, 739K rwdata, 2816K rodata, 2048K init, 854K bss, 132812K reserved, 65536K cma-reserved, 3264512K highmem)
Apr 13 08:37:29 moode kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Apr 13 08:37:29 moode kernel: [    0.000000] ftrace: allocating 31110 entries in 61 pages
Apr 13 08:37:29 moode kernel: [    0.000000] rcu: Hierarchical RCU implementation.
Apr 13 08:37:29 moode kernel: [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Apr 13 08:37:29 moode kernel: [    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Apr 13 08:37:29 moode kernel: [    0.000000] GIC: Using split EOI/Deactivate mode
Apr 13 08:37:29 moode kernel: [    0.000000] random: get_random_bytes called from start_kernel+0x344/0x518 with crng_init=0
Apr 13 08:37:29 moode kernel: [    0.000007] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Apr 13 08:37:29 moode kernel: [    0.000030] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Apr 13 08:37:29 moode kernel: [    0.000108] bcm2835: system timer (irq = 17)
Apr 13 08:37:29 moode kernel: [    0.000759] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Apr 13 08:37:29 moode kernel: [    0.000778] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Apr 13 08:37:29 moode kernel: [    0.000799] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Apr 13 08:37:29 moode kernel: [    0.000814] Switching to timer-based delay loop, resolution 18ns
Apr 13 08:37:29 moode kernel: [    0.001052] Console: colour dummy device 80x30
Apr 13 08:37:29 moode kernel: [    0.001559] printk: console [tty1] enabled
Apr 13 08:37:29 moode kernel: [    0.001623] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
Apr 13 08:37:29 moode kernel: [    0.001665] pid_max: default: 32768 minimum: 301
Apr 13 08:37:29 moode kernel: [    0.001825] LSM: Security Framework initializing
Apr 13 08:37:29 moode kernel: [    0.002027] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Apr 13 08:37:29 moode kernel: [    0.002068] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Apr 13 08:37:29 moode kernel: [    0.003420] Disabling memory control group subsystem
Apr 13 08:37:29 moode kernel: [    0.003557] CPU: Testing write buffer coherency: ok
Apr 13 08:37:29 moode kernel: [    0.004072] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Apr 13 08:37:29 moode kernel: [    0.004990] Setting up static identity map for 0x200000 - 0x20003c
Apr 13 08:37:29 moode kernel: [    0.005210] rcu: Hierarchical SRCU implementation.
Apr 13 08:37:29 moode kernel: [    0.005898] smp: Bringing up secondary CPUs ...
Apr 13 08:37:29 moode kernel: [    0.007069] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Apr 13 08:37:29 moode kernel: [    0.008365] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Apr 13 08:37:29 moode kernel: [    0.009606] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Apr 13 08:37:29 moode kernel: [    0.009765] smp: Brought up 1 node, 4 CPUs
Apr 13 08:37:29 moode kernel: [    0.009836] SMP: Total of 4 processors activated (432.00 BogoMIPS).
Apr 13 08:37:29 moode kernel: [    0.009863] CPU: All CPU(s) started in HYP mode.
Apr 13 08:37:29 moode kernel: [    0.009887] CPU: Virtualization extensions available.
Apr 13 08:37:29 moode kernel: [    0.010728] devtmpfs: initialized
Apr 13 08:37:29 moode kernel: [    0.024447] VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
Apr 13 08:37:29 moode kernel: [    0.024731] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Apr 13 08:37:29 moode kernel: [    0.024781] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Apr 13 08:37:29 moode kernel: [    0.026770] pinctrl core: initialized pinctrl subsystem
Apr 13 08:37:29 moode kernel: [    0.027784] NET: Registered protocol family 16
Apr 13 08:37:29 moode kernel: [    0.031602] DMA: preallocated 1024 KiB pool for atomic coherent allocations
Apr 13 08:37:29 moode kernel: [    0.032211] audit: initializing netlink subsys (disabled)
Apr 13 08:37:29 moode kernel: [    0.032477] audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1
Apr 13 08:37:29 moode kernel: [    0.033582] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Apr 13 08:37:29 moode kernel: [    0.033618] hw-breakpoint: maximum watchpoint size is 8 bytes.
Apr 13 08:37:29 moode kernel: [    0.033942] Serial: AMBA PL011 UART driver
Apr 13 08:37:29 moode kernel: [    0.037608] bcm2835-mbox fe00b880.mailbox: mailbox enabled
Apr 13 08:37:29 moode kernel: [    0.060832] raspberrypi-firmware soc:firmware: Attached to firmware from 2020-11-17 13:40, variant start
Apr 13 08:37:29 moode kernel: [    0.070844] raspberrypi-firmware soc:firmware: Firmware hash is 20c430d6cf4343ed95afba07c4735b7c587a4c83
Apr 13 08:37:29 moode kernel: [    0.124404] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
Apr 13 08:37:29 moode kernel: [    0.129460] vgaarb: loaded
Apr 13 08:37:29 moode kernel: [    0.129937] SCSI subsystem initialized
Apr 13 08:37:29 moode kernel: [    0.130184] usbcore: registered new interface driver usbfs
Apr 13 08:37:29 moode kernel: [    0.130257] usbcore: registered new interface driver hub
Apr 13 08:37:29 moode kernel: [    0.130395] usbcore: registered new device driver usb
Apr 13 08:37:29 moode kernel: [    0.130744] usb_phy_generic phy: phy supply vcc not found, using dummy regulator
Apr 13 08:37:29 moode kernel: [    0.132881] clocksource: Switched to clocksource arch_sys_counter
Apr 13 08:37:29 moode kernel: [    0.830377] VFS: Disk quotas dquot_6.6.0
Apr 13 08:37:29 moode kernel: [    0.830499] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Apr 13 08:37:29 moode kernel: [    0.830678] FS-Cache: Loaded
Apr 13 08:37:29 moode kernel: [    0.830885] CacheFiles: Loaded
Apr 13 08:37:29 moode kernel: [    0.841592] thermal_sys: Registered thermal governor 'step_wise'
Apr 13 08:37:29 moode kernel: [    0.841944] NET: Registered protocol family 2
Apr 13 08:37:29 moode kernel: [    0.842697] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Apr 13 08:37:29 moode kernel: [    0.842749] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Apr 13 08:37:29 moode kernel: [    0.842826] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
Apr 13 08:37:29 moode kernel: [    0.842948] TCP: Hash tables configured (established 8192 bind 8192)
Apr 13 08:37:29 moode kernel: [    0.843112] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Apr 13 08:37:29 moode kernel: [    0.843165] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Apr 13 08:37:29 moode kernel: [    0.843441] NET: Registered protocol family 1
Apr 13 08:37:29 moode kernel: [    0.844193] RPC: Registered named UNIX socket transport module.
Apr 13 08:37:29 moode kernel: [    0.844224] RPC: Registered udp transport module.
Apr 13 08:37:29 moode kernel: [    0.844249] RPC: Registered tcp transport module.
Apr 13 08:37:29 moode kernel: [    0.844274] RPC: Registered tcp NFSv4.1 backchannel transport module.
Apr 13 08:37:29 moode kernel: [    0.844309] PCI: CLS 0 bytes, default 64
Apr 13 08:37:29 moode kernel: [    0.846219] hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available
Apr 13 08:37:29 moode kernel: [    0.848415] Initialise system trusted keyrings
Apr 13 08:37:29 moode kernel: [    0.848655] workingset: timestamp_bits=14 max_order=20 bucket_order=6
Apr 13 08:37:29 moode kernel: [    0.859554] FS-Cache: Netfs 'nfs' registered for caching
Apr 13 08:37:29 moode kernel: [    0.860284] NFS: Registering the id_resolver key type
Apr 13 08:37:29 moode kernel: [    0.860338] Key type id_resolver registered
Apr 13 08:37:29 moode kernel: [    0.860364] Key type id_legacy registered
Apr 13 08:37:29 moode kernel: [    0.860399] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Apr 13 08:37:29 moode kernel: [    0.861508] Key type asymmetric registered
Apr 13 08:37:29 moode kernel: [    0.861538] Asymmetric key parser 'x509' registered
Apr 13 08:37:29 moode kernel: [    0.861744] bounce: pool size: 64 pages
Apr 13 08:37:29 moode kernel: [    0.861807] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Apr 13 08:37:29 moode kernel: [    0.862052] io scheduler mq-deadline registered
Apr 13 08:37:29 moode kernel: [    0.862082] io scheduler kyber registered
Apr 13 08:37:29 moode kernel: [    0.866039] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Apr 13 08:37:29 moode kernel: [    0.866082] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
Apr 13 08:37:29 moode kernel: [    0.866173] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x0603ffffff -> 0x00f8000000
Apr 13 08:37:29 moode kernel: [    0.866264] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00bfffffff -> 0x0000000000
Apr 13 08:37:29 moode kernel: [    0.925029] brcm-pcie fd500000.pcie: link up, 5 GT/s x1 (SSC)
Apr 13 08:37:29 moode kernel: [    0.925362] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Apr 13 08:37:29 moode kernel: [    0.925397] pci_bus 0000:00: root bus resource [bus 00-ff]
Apr 13 08:37:29 moode kernel: [    0.925432] pci_bus 0000:00: root bus resource [mem 0x600000000-0x603ffffff] (bus address [0xf8000000-0xfbffffff])
Apr 13 08:37:29 moode kernel: [    0.925512] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Apr 13 08:37:29 moode kernel: [    0.925795] pci 0000:00:00.0: PME# supported from D0 D3hot
Apr 13 08:37:29 moode kernel: [    0.929076] PCI: bus0: Fast back to back transfers disabled
Apr 13 08:37:29 moode kernel: [    0.929322] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Apr 13 08:37:29 moode kernel: [    0.929484] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Apr 13 08:37:29 moode kernel: [    0.929932] pci 0000:01:00.0: PME# supported from D0 D3cold
Apr 13 08:37:29 moode kernel: [    0.933242] PCI: bus1: Fast back to back transfers disabled
Apr 13 08:37:29 moode kernel: [    0.933317] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Apr 13 08:37:29 moode kernel: [    0.933357] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Apr 13 08:37:29 moode kernel: [    0.933458] pci 0000:00:00.0: PCI bridge to [bus 01]
Apr 13 08:37:29 moode kernel: [    0.933495] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
Apr 13 08:37:29 moode kernel: [    0.933826] pcieport 0000:00:00.0: enabling device (0140 -> 0142)
Apr 13 08:37:29 moode kernel: [    0.934083] pcieport 0000:00:00.0: PME: Signaling with IRQ 54
Apr 13 08:37:29 moode kernel: [    0.934486] pcieport 0000:00:00.0: AER: enabled with IRQ 54
Apr 13 08:37:29 moode kernel: [    0.934839] pci 0000:01:00.0: enabling device (0140 -> 0142)
Apr 13 08:37:29 moode kernel: [    0.935532] bcm2708_fb soc:fb: FB found 1 display(s)
Apr 13 08:37:29 moode kernel: [    0.994059] Console: switching to colour frame buffer device 240x80
Apr 13 08:37:29 moode kernel: [    1.006004] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 1920x1280
Apr 13 08:37:29 moode kernel: [    1.012527] iproc-rng200 fe104000.rng: hwrng registered
Apr 13 08:37:29 moode kernel: [    1.012966] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Apr 13 08:37:29 moode kernel: [    1.013721] vc-sm: Videocore shared memory driver
Apr 13 08:37:29 moode kernel: [    1.014359] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
Apr 13 08:37:29 moode kernel: [    1.026644] brd: module loaded
Apr 13 08:37:29 moode kernel: [    1.039058] loop: module loaded
Apr 13 08:37:29 moode kernel: [    1.040505] Loading iSCSI transport class v2.0-870.
Apr 13 08:37:29 moode kernel: [    1.042589] libphy: Fixed MDIO Bus: probed
Apr 13 08:37:29 moode kernel: [    1.043325] bcmgenet fd580000.ethernet: failed to get enet clock
Apr 13 08:37:29 moode kernel: [    1.043406] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
Apr 13 08:37:29 moode kernel: [    1.043486] bcmgenet fd580000.ethernet: failed to get enet-wol clock
Apr 13 08:37:29 moode kernel: [    1.043569] bcmgenet fd580000.ethernet: failed to get enet-eee clock
Apr 13 08:37:29 moode kernel: [    1.043656] bcmgenet: Skipping UMAC reset
Apr 13 08:37:29 moode kernel: [    1.062966] libphy: bcmgenet MII bus: probed
Apr 13 08:37:29 moode kernel: [    1.143035] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
Apr 13 08:37:29 moode kernel: [    1.144183] usbcore: registered new interface driver r8152
Apr 13 08:37:29 moode kernel: [    1.144309] usbcore: registered new interface driver lan78xx
Apr 13 08:37:29 moode kernel: [    1.144427] usbcore: registered new interface driver smsc95xx
Apr 13 08:37:29 moode kernel: [    1.144946] xhci_hcd 0000:01:00.0: xHCI Host Controller
Apr 13 08:37:29 moode kernel: [    1.145036] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Apr 13 08:37:29 moode kernel: [    1.147538] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000003000000890
Apr 13 08:37:29 moode kernel: [    1.148942] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04
Apr 13 08:37:29 moode kernel: [    1.149038] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 13 08:37:29 moode kernel: [    1.149122] usb usb1: Product: xHCI Host Controller
Apr 13 08:37:29 moode kernel: [    1.149186] usb usb1: Manufacturer: Linux 5.4.77-v7l+ xhci-hcd
Apr 13 08:37:29 moode kernel: [    1.149258] usb usb1: SerialNumber: 0000:01:00.0
Apr 13 08:37:29 moode kernel: [    1.149890] hub 1-0:1.0: USB hub found
Apr 13 08:37:29 moode kernel: [    1.150030] hub 1-0:1.0: 1 port detected
Apr 13 08:37:29 moode kernel: [    1.150635] xhci_hcd 0000:01:00.0: xHCI Host Controller
Apr 13 08:37:29 moode kernel: [    1.150728] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Apr 13 08:37:29 moode kernel: [    1.150822] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Apr 13 08:37:29 moode kernel: [    1.151369] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.04
Apr 13 08:37:29 moode kernel: [    1.151463] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 13 08:37:29 moode kernel: [    1.151546] usb usb2: Product: xHCI Host Controller
Apr 13 08:37:29 moode kernel: [    1.151609] usb usb2: Manufacturer: Linux 5.4.77-v7l+ xhci-hcd
Apr 13 08:37:29 moode kernel: [    1.151681] usb usb2: SerialNumber: 0000:01:00.0
Apr 13 08:37:29 moode kernel: [    1.152314] hub 2-0:1.0: USB hub found
Apr 13 08:37:29 moode kernel: [    1.152433] hub 2-0:1.0: 4 ports detected
Apr 13 08:37:29 moode kernel: [    1.154078] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Apr 13 08:37:29 moode kernel: [    1.155002] usbcore: registered new interface driver uas
Apr 13 08:37:29 moode kernel: [    1.155161] usbcore: registered new interface driver usb-storage
Apr 13 08:37:29 moode kernel: [    1.155407] mousedev: PS/2 mouse device common for all mice
Apr 13 08:37:29 moode kernel: [    1.157317] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Apr 13 08:37:29 moode kernel: [    1.160798] sdhci: Secure Digital Host Controller Interface driver
Apr 13 08:37:29 moode kernel: [    1.163898] sdhci: Copyright(c) Pierre Ossman
Apr 13 08:37:29 moode kernel: [    1.167452] sdhci-pltfm: SDHCI platform and OF driver helper
Apr 13 08:37:29 moode kernel: [    1.173729] ledtrig-cpu: registered to indicate activity on CPUs
Apr 13 08:37:29 moode kernel: [    1.177021] hidraw: raw HID events driver (C) Jiri Kosina
Apr 13 08:37:29 moode kernel: [    1.180139] usbcore: registered new interface driver usbhid
Apr 13 08:37:29 moode kernel: [    1.183130] usbhid: USB HID core driver
Apr 13 08:37:29 moode kernel: [    1.187065] vchiq: vchiq_init_state: slot_zero = (ptrval)
Apr 13 08:37:29 moode kernel: [    1.191754] [vc_sm_connected_init]: start
Apr 13 08:37:29 moode kernel: [    1.202433] [vc_sm_connected_init]: end - returning 0
Apr 13 08:37:29 moode kernel: [    1.207350] Initializing XFRM netlink socket
Apr 13 08:37:29 moode kernel: [    1.210289] NET: Registered protocol family 17
Apr 13 08:37:29 moode kernel: [    1.213325] Key type dns_resolver registered
Apr 13 08:37:29 moode kernel: [    1.216567] Registering SWP/SWPB emulation handler
Apr 13 08:37:29 moode kernel: [    1.219759] registered taskstats version 1
Apr 13 08:37:29 moode kernel: [    1.222638] Loading compiled-in X.509 certificates
Apr 13 08:37:29 moode kernel: [    1.226041] Key type ._fscrypt registered
Apr 13 08:37:29 moode kernel: [    1.228884] Key type .fscrypt registered
Apr 13 08:37:29 moode kernel: [    1.242438] uart-pl011 fe201000.serial: cts_event_workaround enabled
Apr 13 08:37:29 moode kernel: [    1.245448] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 29, base_baud = 0) is a PL011 rev2
Apr 13 08:37:29 moode kernel: [    1.254470] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Apr 13 08:37:29 moode kernel: [    1.295931] mmc0: SDHCI controller on fe340000.emmc2 [fe340000.emmc2] using ADMA
Apr 13 08:37:29 moode kernel: [    1.301847] of_cfs_init
Apr 13 08:37:29 moode kernel: [    1.304951] of_cfs_init: OK
Apr 13 08:37:29 moode kernel: [    1.308909] Waiting for root device PARTUUID=067e19d7-02...
Apr 13 08:37:29 moode kernel: [    1.403978] mmc0: new ultra high speed DDR50 SDHC card at address e624
Apr 13 08:37:29 moode kernel: [    1.407879] mmcblk0: mmc0:e624 SR32G 29.7 GiB
Apr 13 08:37:29 moode kernel: [    1.413137]  mmcblk0: p1 p2
Apr 13 08:37:29 moode kernel: [    1.431310] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Apr 13 08:37:29 moode kernel: [    1.434407] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Apr 13 08:37:29 moode kernel: [    1.442466] devtmpfs: mounted
Apr 13 08:37:29 moode kernel: [    1.454107] Freeing unused kernel memory: 2048K
Apr 13 08:37:29 moode kernel: [    1.473200] Run /sbin/init as init process
Apr 13 08:37:29 moode kernel: [    1.512939] usb 1-1: new high-speed USB device number 2 using xhci_hcd
Apr 13 08:37:29 moode kernel: [    1.568388] random: fast init done
Apr 13 08:37:29 moode kernel: [    1.695583] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Apr 13 08:37:29 moode kernel: [    1.698585] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Apr 13 08:37:29 moode kernel: [    1.701543] usb 1-1: Product: USB2.0 Hub
Apr 13 08:37:29 moode kernel: [    1.706477] hub 1-1:1.0: USB hub found
Apr 13 08:37:29 moode kernel: [    1.709740] hub 1-1:1.0: 4 ports detected
Apr 13 08:37:29 moode kernel: [    1.991048] NET: Registered protocol family 10
Apr 13 08:37:29 moode kernel: [    1.995393] Segment Routing with IPv6
Apr 13 08:37:29 moode kernel: [    2.683239] random: systemd: uninitialized urandom read (16 bytes read)
Apr 13 08:37:29 moode kernel: [    2.832620] random: systemd: uninitialized urandom read (16 bytes read)
Apr 13 08:37:29 moode kernel: [    2.845870] random: systemd: uninitialized urandom read (16 bytes read)
Apr 13 08:37:29 moode kernel: [    3.651655] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Apr 13 08:37:29 moode kernel: [    4.400067] rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000
Apr 13 08:37:29 moode kernel: [    4.400848] rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000
Apr 13 08:37:29 moode kernel: [    4.401874] rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000
Apr 13 08:37:29 moode kernel: [    4.402770] rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000
Apr 13 08:37:29 moode kernel: [    4.470301] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:37:29 moode kernel: [    4.472357] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Apr 13 08:37:29 moode kernel: [    4.472378] [vc_sm_connected_init]: start
Apr 13 08:37:29 moode kernel: [    4.476198] mc: Linux media interface: v0.10
Apr 13 08:37:29 moode kernel: [    4.477043] [vc_sm_connected_init]: installed successfully
Apr 13 08:37:29 moode kernel: [    4.508645] videodev: Linux video capture interface: v2.00
Apr 13 08:37:29 moode kernel: [    4.550161] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:37:29 moode kernel: [    4.556407] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:37:29 moode kernel: [    4.579762] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Apr 13 08:37:29 moode kernel: [    4.579805] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Apr 13 08:37:29 moode kernel: [    4.585977] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Apr 13 08:37:29 moode kernel: [    4.586022] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Apr 13 08:37:29 moode kernel: [    4.587497] snd_soc_pcm1794a: loading out-of-tree module taints kernel.
Apr 13 08:37:29 moode kernel: [    4.595784] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Apr 13 08:37:29 moode kernel: [    4.595841] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Apr 13 08:37:29 moode kernel: [    4.600339] snd-rpi-simple soc:sound: pcm1794a-codec <-> fe203000.i2s mapping ok
Apr 13 08:37:29 moode kernel: [    4.600846] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:37:29 moode kernel: [    4.667769] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:37:29 moode kernel: [    4.752991] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Apr 13 08:37:29 moode kernel: [    4.753493] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Apr 13 08:37:29 moode kernel: [    4.753958] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Apr 13 08:37:29 moode kernel: [    4.754276] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Apr 13 08:37:29 moode kernel: [    4.754303] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Apr 13 08:37:29 moode kernel: [    4.754325] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Apr 13 08:37:29 moode kernel: [    4.754346] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Apr 13 08:37:29 moode kernel: [    4.754366] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Apr 13 08:37:29 moode kernel: [    4.754550] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Apr 13 08:37:29 moode rsyslogd: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd.  [v8.1901.0]
Apr 13 08:37:29 moode rsyslogd:  [origin software="rsyslogd" swVersion="8.1901.0" x-pid="342" x-info="https://www.rsyslog.com"] start
Apr 13 08:37:29 moode kernel: [    7.069274] random: crng init done
Apr 13 08:37:29 moode kernel: [    7.069291] random: 7 urandom warning(s) missed due to ratelimiting
Apr 13 08:37:30 moode kernel: [    7.165335] 8021q: 802.1Q VLAN Support v1.8
Apr 13 08:37:30 moode kernel: [    7.262183] cfg80211: Loading compiled-in X.509 certificates for regulatory database
Apr 13 08:37:30 moode kernel: [    7.298101] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Apr 13 08:37:30 moode kernel: [    7.378276] bcmgenet: Skipping UMAC reset
Apr 13 08:37:30 moode kernel: [    7.381188] bcmgenet fd580000.ethernet: configuring instance for external RGMII
Apr 13 08:37:30 moode kernel: [    7.381706] bcmgenet fd580000.ethernet eth0: Link is Down
Apr 13 08:37:35 moode kernel: [   12.553101] bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
Apr 13 08:37:35 moode kernel: [   12.553150] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Apr 13 08:37:35 moode kernel: [   12.712972] Voltage normalised (0x00000000)
Apr 13 08:37:42 moode rfkill: unblock set for type wifi
Apr 13 08:37:47 moode kernel: [   24.814603] uart-pl011 fe201000.serial: no DMA platform data
Apr 13 08:37:52 moode kernel: [   29.352981] Voltage normalised (0x00000000)
Apr 13 08:37:54 moode kernel: [   31.503615] Bluetooth: Core ver 2.22
Apr 13 08:37:54 moode kernel: [   31.503698] NET: Registered protocol family 31
Apr 13 08:37:54 moode kernel: [   31.503712] Bluetooth: HCI device and connection manager initialized
Apr 13 08:37:54 moode kernel: [   31.503739] Bluetooth: HCI socket layer initialized
Apr 13 08:37:54 moode kernel: [   31.503759] Bluetooth: L2CAP socket layer initialized
Apr 13 08:37:54 moode kernel: [   31.503790] Bluetooth: SCO socket layer initialized
Apr 13 08:37:54 moode kernel: [   31.511912] Bluetooth: HCI UART driver ver 2.3
Apr 13 08:37:54 moode kernel: [   31.511931] Bluetooth: HCI UART protocol H4 registered
Apr 13 08:37:54 moode kernel: [   31.512015] Bluetooth: HCI UART protocol Three-wire (H5) registered
Apr 13 08:37:54 moode kernel: [   31.512323] Bluetooth: HCI UART protocol Broadcom registered
Apr 13 08:37:54 moode kernel: [   31.650390] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Apr 13 08:37:54 moode kernel: [   31.650397] Bluetooth: BNEP filters: protocol multicast
Apr 13 08:37:54 moode kernel: [   31.650409] Bluetooth: BNEP socket layer initialized
Apr 13 08:37:58 moode kernel: [   35.155189] FS-Cache: Netfs 'cifs' registered for caching
Apr 13 08:37:58 moode kernel: [   35.171359] Key type cifs.spnego registered
Apr 13 08:37:58 moode kernel: [   35.171386] Key type cifs.idmap registered
Apr 13 08:37:58 moode kernel: [   35.172587] CIFS: Attempting to mount //DISKSTATION/music
The following is a shutdown where I start up moode, play a file, connect to bluetooth, play a song over bluetooth, disconnect, play the first file, and then shutdown. At this point the shutdown option in the moode GUI does not work, and I have to do a : shutdown -P now, which results in the following:

Code:
Apr 13 08:52:19 moode kernel: [    0.000000] Booting Linux on physical CPU 0x0
Apr 13 08:52:19 moode kernel: [    0.000000] Linux version 5.4.77-v7l+ (dom@buildbot) (gcc version 8.4.0 (Ubuntu/Linaro 8.4.0-3ubuntu1)) #1371 SMP Tue Nov 17 13:35:27 GMT 2020
Apr 13 08:52:19 moode kernel: [    0.000000] CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d
Apr 13 08:52:19 moode kernel: [    0.000000] CPU: div instructions available: patching division code
Apr 13 08:52:19 moode kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
Apr 13 08:52:19 moode kernel: [    0.000000] OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.1
Apr 13 08:52:19 moode kernel: [    0.000000] Memory policy: Data cache writealloc
Apr 13 08:52:19 moode kernel: [    0.000000] Reserved memory: created CMA memory pool at 0x000000002ac00000, size 64 MiB
Apr 13 08:52:19 moode kernel: [    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Apr 13 08:52:19 moode kernel: [    0.000000] percpu: Embedded 20 pages/cpu s49804 r8192 d23924 u81920
Apr 13 08:52:19 moode kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1010432
Apr 13 08:52:19 moode kernel: [    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:44:A8:7F vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  net.ifnames=0 console=ttyS0,115200 console=tty1 root=PARTUUID=067e19d7-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
Apr 13 08:52:19 moode kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
Apr 13 08:52:19 moode kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Apr 13 08:52:19 moode kernel: [    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
Apr 13 08:52:19 moode kernel: [    0.000000] software IO TLB: mapped [mem 0x23cc0000-0x27cc0000] (64MB)
Apr 13 08:52:19 moode kernel: [    0.000000] Memory: 3852596K/4050944K available (10240K kernel code, 739K rwdata, 2816K rodata, 2048K init, 854K bss, 132812K reserved, 65536K cma-reserved, 3264512K highmem)
Apr 13 08:52:19 moode kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Apr 13 08:52:19 moode kernel: [    0.000000] ftrace: allocating 31110 entries in 61 pages
Apr 13 08:52:19 moode kernel: [    0.000000] rcu: Hierarchical RCU implementation.
Apr 13 08:52:19 moode kernel: [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Apr 13 08:52:19 moode kernel: [    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Apr 13 08:52:19 moode kernel: [    0.000000] GIC: Using split EOI/Deactivate mode
Apr 13 08:52:19 moode kernel: [    0.000000] random: get_random_bytes called from start_kernel+0x344/0x518 with crng_init=0
Apr 13 08:52:19 moode kernel: [    0.000008] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Apr 13 08:52:19 moode kernel: [    0.000031] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Apr 13 08:52:19 moode kernel: [    0.000110] bcm2835: system timer (irq = 17)
Apr 13 08:52:19 moode kernel: [    0.000760] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Apr 13 08:52:19 moode kernel: [    0.000779] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Apr 13 08:52:19 moode kernel: [    0.000800] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Apr 13 08:52:19 moode kernel: [    0.000816] Switching to timer-based delay loop, resolution 18ns
Apr 13 08:52:19 moode kernel: [    0.001056] Console: colour dummy device 80x30
Apr 13 08:52:19 moode kernel: [    0.001565] printk: console [tty1] enabled
Apr 13 08:52:19 moode kernel: [    0.001628] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000)
Apr 13 08:52:19 moode kernel: [    0.001671] pid_max: default: 32768 minimum: 301
Apr 13 08:52:19 moode kernel: [    0.001831] LSM: Security Framework initializing
Apr 13 08:52:19 moode kernel: [    0.002036] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Apr 13 08:52:19 moode kernel: [    0.002078] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Apr 13 08:52:19 moode kernel: [    0.003442] Disabling memory control group subsystem
Apr 13 08:52:19 moode kernel: [    0.003580] CPU: Testing write buffer coherency: ok
Apr 13 08:52:19 moode kernel: [    0.004099] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Apr 13 08:52:19 moode kernel: [    0.005021] Setting up static identity map for 0x200000 - 0x20003c
Apr 13 08:52:19 moode kernel: [    0.005242] rcu: Hierarchical SRCU implementation.
Apr 13 08:52:19 moode kernel: [    0.005932] smp: Bringing up secondary CPUs ...
Apr 13 08:52:19 moode kernel: [    0.007120] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Apr 13 08:52:19 moode kernel: [    0.008431] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Apr 13 08:52:19 moode kernel: [    0.009680] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Apr 13 08:52:19 moode kernel: [    0.009840] smp: Brought up 1 node, 4 CPUs
Apr 13 08:52:19 moode kernel: [    0.009912] SMP: Total of 4 processors activated (432.00 BogoMIPS).
Apr 13 08:52:19 moode kernel: [    0.009939] CPU: All CPU(s) started in HYP mode.
Apr 13 08:52:19 moode kernel: [    0.009964] CPU: Virtualization extensions available.
Apr 13 08:52:19 moode kernel: [    0.010806] devtmpfs: initialized
Apr 13 08:52:19 moode kernel: [    0.024575] VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0
Apr 13 08:52:19 moode kernel: [    0.024862] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Apr 13 08:52:19 moode kernel: [    0.024913] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Apr 13 08:52:19 moode kernel: [    0.026903] pinctrl core: initialized pinctrl subsystem
Apr 13 08:52:19 moode kernel: [    0.027924] NET: Registered protocol family 16
Apr 13 08:52:19 moode kernel: [    0.031910] DMA: preallocated 1024 KiB pool for atomic coherent allocations
Apr 13 08:52:19 moode kernel: [    0.032523] audit: initializing netlink subsys (disabled)
Apr 13 08:52:19 moode kernel: [    0.032797] audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1
Apr 13 08:52:19 moode kernel: [    0.033909] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Apr 13 08:52:19 moode kernel: [    0.033945] hw-breakpoint: maximum watchpoint size is 8 bytes.
Apr 13 08:52:19 moode kernel: [    0.034275] Serial: AMBA PL011 UART driver
Apr 13 08:52:19 moode kernel: [    0.037946] bcm2835-mbox fe00b880.mailbox: mailbox enabled
Apr 13 08:52:19 moode kernel: [    0.060827] raspberrypi-firmware soc:firmware: Attached to firmware from 2020-11-17 13:40, variant start
Apr 13 08:52:19 moode kernel: [    0.070843] raspberrypi-firmware soc:firmware: Firmware hash is 20c430d6cf4343ed95afba07c4735b7c587a4c83
Apr 13 08:52:19 moode kernel: [    0.124816] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
Apr 13 08:52:19 moode kernel: [    0.129893] vgaarb: loaded
Apr 13 08:52:19 moode kernel: [    0.130371] SCSI subsystem initialized
Apr 13 08:52:19 moode kernel: [    0.130621] usbcore: registered new interface driver usbfs
Apr 13 08:52:19 moode kernel: [    0.130694] usbcore: registered new interface driver hub
Apr 13 08:52:19 moode kernel: [    0.130831] usbcore: registered new device driver usb
Apr 13 08:52:19 moode kernel: [    0.131224] usb_phy_generic phy: phy supply vcc not found, using dummy regulator
Apr 13 08:52:19 moode kernel: [    0.133059] clocksource: Switched to clocksource arch_sys_counter
Apr 13 08:52:19 moode kernel: [    0.831221] VFS: Disk quotas dquot_6.6.0
Apr 13 08:52:19 moode kernel: [    0.831344] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Apr 13 08:52:19 moode kernel: [    0.831523] FS-Cache: Loaded
Apr 13 08:52:19 moode kernel: [    0.831728] CacheFiles: Loaded
Apr 13 08:52:19 moode kernel: [    0.842066] thermal_sys: Registered thermal governor 'step_wise'
Apr 13 08:52:19 moode kernel: [    0.842426] NET: Registered protocol family 2
Apr 13 08:52:19 moode kernel: [    0.843438] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Apr 13 08:52:19 moode kernel: [    0.843491] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
Apr 13 08:52:19 moode kernel: [    0.843568] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
Apr 13 08:52:19 moode kernel: [    0.843651] TCP: Hash tables configured (established 8192 bind 8192)
Apr 13 08:52:19 moode kernel: [    0.843815] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
Apr 13 08:52:19 moode kernel: [    0.843869] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
Apr 13 08:52:19 moode kernel: [    0.844144] NET: Registered protocol family 1
Apr 13 08:52:19 moode kernel: [    0.844900] RPC: Registered named UNIX socket transport module.
Apr 13 08:52:19 moode kernel: [    0.844931] RPC: Registered udp transport module.
Apr 13 08:52:19 moode kernel: [    0.844957] RPC: Registered tcp transport module.
Apr 13 08:52:19 moode kernel: [    0.844982] RPC: Registered tcp NFSv4.1 backchannel transport module.
Apr 13 08:52:19 moode kernel: [    0.845017] PCI: CLS 0 bytes, default 64
Apr 13 08:52:19 moode kernel: [    0.846940] hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available
Apr 13 08:52:19 moode kernel: [    0.849150] Initialise system trusted keyrings
Apr 13 08:52:19 moode kernel: [    0.849393] workingset: timestamp_bits=14 max_order=20 bucket_order=6
Apr 13 08:52:19 moode kernel: [    0.860297] FS-Cache: Netfs 'nfs' registered for caching
Apr 13 08:52:19 moode kernel: [    0.861032] NFS: Registering the id_resolver key type
Apr 13 08:52:19 moode kernel: [    0.861080] Key type id_resolver registered
Apr 13 08:52:19 moode kernel: [    0.861107] Key type id_legacy registered
Apr 13 08:52:19 moode kernel: [    0.861142] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Apr 13 08:52:19 moode kernel: [    0.862260] Key type asymmetric registered
Apr 13 08:52:19 moode kernel: [    0.862290] Asymmetric key parser 'x509' registered
Apr 13 08:52:19 moode kernel: [    0.862496] bounce: pool size: 64 pages
Apr 13 08:52:19 moode kernel: [    0.862559] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Apr 13 08:52:19 moode kernel: [    0.862803] io scheduler mq-deadline registered
Apr 13 08:52:19 moode kernel: [    0.862832] io scheduler kyber registered
Apr 13 08:52:19 moode kernel: [    0.866895] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Apr 13 08:52:19 moode kernel: [    0.866938] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
Apr 13 08:52:19 moode kernel: [    0.867029] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x0603ffffff -> 0x00f8000000
Apr 13 08:52:19 moode kernel: [    0.867120] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00bfffffff -> 0x0000000000
Apr 13 08:52:19 moode kernel: [    0.905223] brcm-pcie fd500000.pcie: link up, 5 GT/s x1 (SSC)
Apr 13 08:52:19 moode kernel: [    0.905559] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Apr 13 08:52:19 moode kernel: [    0.905594] pci_bus 0000:00: root bus resource [bus 00-ff]
Apr 13 08:52:19 moode kernel: [    0.905628] pci_bus 0000:00: root bus resource [mem 0x600000000-0x603ffffff] (bus address [0xf8000000-0xfbffffff])
Apr 13 08:52:19 moode kernel: [    0.905708] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Apr 13 08:52:19 moode kernel: [    0.905994] pci 0000:00:00.0: PME# supported from D0 D3hot
Apr 13 08:52:19 moode kernel: [    0.909278] PCI: bus0: Fast back to back transfers disabled
Apr 13 08:52:19 moode kernel: [    0.909524] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Apr 13 08:52:19 moode kernel: [    0.909686] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Apr 13 08:52:19 moode kernel: [    0.910135] pci 0000:01:00.0: PME# supported from D0 D3cold
Apr 13 08:52:19 moode kernel: [    0.913425] PCI: bus1: Fast back to back transfers disabled
Apr 13 08:52:19 moode kernel: [    0.913501] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Apr 13 08:52:19 moode kernel: [    0.913540] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Apr 13 08:52:19 moode kernel: [    0.913642] pci 0000:00:00.0: PCI bridge to [bus 01]
Apr 13 08:52:19 moode kernel: [    0.913680] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
Apr 13 08:52:19 moode kernel: [    0.914010] pcieport 0000:00:00.0: enabling device (0140 -> 0142)
Apr 13 08:52:19 moode kernel: [    0.914265] pcieport 0000:00:00.0: PME: Signaling with IRQ 54
Apr 13 08:52:19 moode kernel: [    0.914671] pcieport 0000:00:00.0: AER: enabled with IRQ 54
Apr 13 08:52:19 moode kernel: [    0.915024] pci 0000:01:00.0: enabling device (0140 -> 0142)
Apr 13 08:52:19 moode kernel: [    0.915752] bcm2708_fb soc:fb: FB found 1 display(s)
Apr 13 08:52:19 moode kernel: [    0.926236] Console: switching to colour frame buffer device 80x30
Apr 13 08:52:19 moode kernel: [    0.929210] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480
Apr 13 08:52:19 moode kernel: [    0.937609] iproc-rng200 fe104000.rng: hwrng registered
Apr 13 08:52:19 moode kernel: [    0.938883] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Apr 13 08:52:19 moode kernel: [    0.941442] vc-sm: Videocore shared memory driver
Apr 13 08:52:19 moode kernel: [    0.942974] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
Apr 13 08:52:19 moode kernel: [    0.957259] brd: module loaded
Apr 13 08:52:19 moode kernel: [    0.970653] loop: module loaded
Apr 13 08:52:19 moode kernel: [    0.973032] Loading iSCSI transport class v2.0-870.
Apr 13 08:52:19 moode kernel: [    0.976044] libphy: Fixed MDIO Bus: probed
Apr 13 08:52:19 moode kernel: [    0.977619] bcmgenet fd580000.ethernet: failed to get enet clock
Apr 13 08:52:19 moode kernel: [    0.978594] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
Apr 13 08:52:19 moode kernel: [    0.979546] bcmgenet fd580000.ethernet: failed to get enet-wol clock
Apr 13 08:52:19 moode kernel: [    0.980512] bcmgenet fd580000.ethernet: failed to get enet-eee clock
Apr 13 08:52:19 moode kernel: [    0.981440] bcmgenet: Skipping UMAC reset
Apr 13 08:52:19 moode kernel: [    0.993142] libphy: bcmgenet MII bus: probed
Apr 13 08:52:19 moode kernel: [    1.083176] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
Apr 13 08:52:19 moode kernel: [    1.085100] usbcore: registered new interface driver r8152
Apr 13 08:52:19 moode kernel: [    1.086087] usbcore: registered new interface driver lan78xx
Apr 13 08:52:19 moode kernel: [    1.087043] usbcore: registered new interface driver smsc95xx
Apr 13 08:52:19 moode kernel: [    1.088347] xhci_hcd 0000:01:00.0: xHCI Host Controller
Apr 13 08:52:19 moode kernel: [    1.089255] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Apr 13 08:52:19 moode kernel: [    1.093410] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000003000000890
Apr 13 08:52:19 moode kernel: [    1.096469] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04
Apr 13 08:52:19 moode kernel: [    1.098256] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 13 08:52:19 moode kernel: [    1.100053] usb usb1: Product: xHCI Host Controller
Apr 13 08:52:19 moode kernel: [    1.100958] usb usb1: Manufacturer: Linux 5.4.77-v7l+ xhci-hcd
Apr 13 08:52:19 moode kernel: [    1.101880] usb usb1: SerialNumber: 0000:01:00.0
Apr 13 08:52:19 moode kernel: [    1.103475] hub 1-0:1.0: USB hub found
Apr 13 08:52:19 moode kernel: [    1.104478] hub 1-0:1.0: 1 port detected
Apr 13 08:52:19 moode kernel: [    1.105930] xhci_hcd 0000:01:00.0: xHCI Host Controller
Apr 13 08:52:19 moode kernel: [    1.106853] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Apr 13 08:52:19 moode kernel: [    1.108666] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Apr 13 08:52:19 moode kernel: [    1.110171] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.04
Apr 13 08:52:19 moode kernel: [    1.112149] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Apr 13 08:52:19 moode kernel: [    1.114208] usb usb2: Product: xHCI Host Controller
Apr 13 08:52:19 moode kernel: [    1.115266] usb usb2: Manufacturer: Linux 5.4.77-v7l+ xhci-hcd
Apr 13 08:52:19 moode kernel: [    1.116350] usb usb2: SerialNumber: 0000:01:00.0
Apr 13 08:52:19 moode kernel: [    1.118070] hub 2-0:1.0: USB hub found
Apr 13 08:52:19 moode kernel: [    1.119190] hub 2-0:1.0: 4 ports detected
Apr 13 08:52:19 moode kernel: [    1.121701] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Apr 13 08:52:19 moode kernel: [    1.123563] usbcore: registered new interface driver uas
Apr 13 08:52:19 moode kernel: [    1.124660] usbcore: registered new interface driver usb-storage
Apr 13 08:52:19 moode kernel: [    1.125835] mousedev: PS/2 mouse device common for all mice
Apr 13 08:52:19 moode kernel: [    1.128655] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Apr 13 08:52:19 moode kernel: [    1.133180] sdhci: Secure Digital Host Controller Interface driver
Apr 13 08:52:19 moode kernel: [    1.134122] sdhci: Copyright(c) Pierre Ossman
Apr 13 08:52:19 moode kernel: [    1.135620] sdhci-pltfm: SDHCI platform and OF driver helper
Apr 13 08:52:19 moode kernel: [    1.139798] ledtrig-cpu: registered to indicate activity on CPUs
Apr 13 08:52:19 moode kernel: [    1.141066] hidraw: raw HID events driver (C) Jiri Kosina
Apr 13 08:52:19 moode kernel: [    1.142201] usbcore: registered new interface driver usbhid
Apr 13 08:52:19 moode kernel: [    1.143210] usbhid: USB HID core driver
Apr 13 08:52:19 moode kernel: [    1.145213] vchiq: vchiq_init_state: slot_zero = (ptrval)
Apr 13 08:52:19 moode kernel: [    1.148146] [vc_sm_connected_init]: start
Apr 13 08:52:19 moode kernel: [    1.157380] [vc_sm_connected_init]: end - returning 0
Apr 13 08:52:19 moode kernel: [    1.160236] Initializing XFRM netlink socket
Apr 13 08:52:19 moode kernel: [    1.161169] NET: Registered protocol family 17
Apr 13 08:52:19 moode kernel: [    1.162161] Key type dns_resolver registered
Apr 13 08:52:19 moode kernel: [    1.163451] Registering SWP/SWPB emulation handler
Apr 13 08:52:19 moode kernel: [    1.164635] registered taskstats version 1
Apr 13 08:52:19 moode kernel: [    1.165466] Loading compiled-in X.509 certificates
Apr 13 08:52:19 moode kernel: [    1.166800] Key type ._fscrypt registered
Apr 13 08:52:19 moode kernel: [    1.167622] Key type .fscrypt registered
Apr 13 08:52:19 moode kernel: [    1.179109] uart-pl011 fe201000.serial: cts_event_workaround enabled
Apr 13 08:52:19 moode kernel: [    1.180044] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 29, base_baud = 0) is a PL011 rev2
Apr 13 08:52:19 moode kernel: [    1.187843] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Apr 13 08:52:19 moode kernel: [    1.225996] mmc0: SDHCI controller on fe340000.emmc2 [fe340000.emmc2] using ADMA
Apr 13 08:52:19 moode kernel: [    1.230802] of_cfs_init
Apr 13 08:52:19 moode kernel: [    1.231971] of_cfs_init: OK
Apr 13 08:52:19 moode kernel: [    1.233999] Waiting for root device PARTUUID=067e19d7-02...
Apr 13 08:52:19 moode kernel: [    1.332847] mmc0: new ultra high speed DDR50 SDHC card at address e624
Apr 13 08:52:19 moode kernel: [    1.334762] mmcblk0: mmc0:e624 SR32G 29.7 GiB
Apr 13 08:52:19 moode kernel: [    1.337745]  mmcblk0: p1 p2
Apr 13 08:52:19 moode kernel: [    1.361131] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Apr 13 08:52:19 moode kernel: [    1.363019] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Apr 13 08:52:19 moode kernel: [    1.369179] devtmpfs: mounted
Apr 13 08:52:19 moode kernel: [    1.378829] Freeing unused kernel memory: 2048K
Apr 13 08:52:19 moode kernel: [    1.393375] Run /sbin/init as init process
Apr 13 08:52:19 moode kernel: [    1.473613] usb 1-1: new high-speed USB device number 2 using xhci_hcd
Apr 13 08:52:19 moode kernel: [    1.484359] random: fast init done
Apr 13 08:52:19 moode kernel: [    1.655776] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Apr 13 08:52:19 moode kernel: [    1.657890] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Apr 13 08:52:19 moode kernel: [    1.659024] usb 1-1: Product: USB2.0 Hub
Apr 13 08:52:19 moode kernel: [    1.662601] hub 1-1:1.0: USB hub found
Apr 13 08:52:19 moode kernel: [    1.663998] hub 1-1:1.0: 4 ports detected
Apr 13 08:52:19 moode kernel: [    1.904377] NET: Registered protocol family 10
Apr 13 08:52:19 moode kernel: [    1.906751] Segment Routing with IPv6
Apr 13 08:52:19 moode rsyslogd: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd.  [v8.1901.0]
Apr 13 08:52:19 moode rsyslogd:  [origin software="rsyslogd" swVersion="8.1901.0" x-pid="362" x-info="https://www.rsyslog.com"] start
Apr 13 08:52:19 moode kernel: [    2.578929] random: systemd: uninitialized urandom read (16 bytes read)
Apr 13 08:52:19 moode kernel: [    2.724981] random: systemd: uninitialized urandom read (16 bytes read)
Apr 13 08:52:19 moode kernel: [    2.731020] random: systemd: uninitialized urandom read (16 bytes read)
Apr 13 08:52:19 moode kernel: [    3.407352] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Apr 13 08:52:19 moode kernel: [    4.105433] rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000
Apr 13 08:52:19 moode kernel: [    4.106861] rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000
Apr 13 08:52:19 moode kernel: [    4.117694] rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000
Apr 13 08:52:19 moode kernel: [    4.122553] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:52:19 moode kernel: [    4.128304] rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000
Apr 13 08:52:19 moode kernel: [    4.131121] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Apr 13 08:52:19 moode kernel: [    4.131143] [vc_sm_connected_init]: start
Apr 13 08:52:19 moode kernel: [    4.135621] [vc_sm_connected_init]: installed successfully
Apr 13 08:52:19 moode kernel: [    4.152571] mc: Linux media interface: v0.10
Apr 13 08:52:19 moode kernel: [    4.202323] videodev: Linux video capture interface: v2.00
Apr 13 08:52:19 moode kernel: [    4.250286] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:52:19 moode kernel: [    4.251624] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:52:19 moode kernel: [    4.253094] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:52:19 moode kernel: [    4.259188] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:52:19 moode kernel: [    4.272375] snd_soc_pcm1794a: loading out-of-tree module taints kernel.
Apr 13 08:52:19 moode kernel: [    4.273030] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Apr 13 08:52:19 moode kernel: [    4.273169] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:52:19 moode kernel: [    4.274072] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Apr 13 08:52:19 moode kernel: [    4.274505] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Apr 13 08:52:19 moode kernel: [    4.274923] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Apr 13 08:52:19 moode kernel: [    4.274956] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Apr 13 08:52:19 moode kernel: [    4.274983] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Apr 13 08:52:19 moode kernel: [    4.275004] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Apr 13 08:52:19 moode kernel: [    4.275024] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Apr 13 08:52:19 moode kernel: [    4.275243] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Apr 13 08:52:19 moode kernel: [    4.283843] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Apr 13 08:52:19 moode kernel: [    4.300775] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Apr 13 08:52:19 moode kernel: [    4.300823] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Apr 13 08:52:19 moode kernel: [    4.311777] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Apr 13 08:52:19 moode kernel: [    4.311805] snd-rpi-simple soc:sound: pcm1794a-codec <-> fe203000.i2s mapping ok
Apr 13 08:52:19 moode kernel: [    4.311878] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Apr 13 08:52:19 moode kernel: [    4.326020] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Apr 13 08:52:19 moode kernel: [    4.326079] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Apr 13 08:52:19 moode kernel: [    6.645536] 8021q: 802.1Q VLAN Support v1.8
Apr 13 08:52:19 moode kernel: [    6.786845] random: crng init done
Apr 13 08:52:19 moode kernel: [    6.786863] random: 7 urandom warning(s) missed due to ratelimiting
Apr 13 08:52:19 moode kernel: [    6.805500] cfg80211: Loading compiled-in X.509 certificates for regulatory database
Apr 13 08:52:20 moode kernel: [    6.964607] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Apr 13 08:52:20 moode kernel: [    7.014908] bcmgenet: Skipping UMAC reset
Apr 13 08:52:20 moode kernel: [    7.016595] bcmgenet fd580000.ethernet: configuring instance for external RGMII
Apr 13 08:52:20 moode kernel: [    7.016815] bcmgenet fd580000.ethernet eth0: Link is Down
Apr 13 08:52:25 moode kernel: [   12.233297] bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
Apr 13 08:52:25 moode kernel: [   12.233347] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Apr 13 08:52:31 moode rfkill: unblock set for type wifi
Apr 13 08:52:36 moode kernel: [   23.909948] uart-pl011 fe201000.serial: no DMA platform data
Apr 13 08:52:42 moode kernel: [   29.193170] Voltage normalised (0x00000000)
Apr 13 08:52:43 moode kernel: [   30.593448] Bluetooth: Core ver 2.22
Apr 13 08:52:43 moode kernel: [   30.593519] NET: Registered protocol family 31
Apr 13 08:52:43 moode kernel: [   30.593529] Bluetooth: HCI device and connection manager initialized
Apr 13 08:52:43 moode kernel: [   30.593550] Bluetooth: HCI socket layer initialized
Apr 13 08:52:43 moode kernel: [   30.593565] Bluetooth: L2CAP socket layer initialized
Apr 13 08:52:43 moode kernel: [   30.593590] Bluetooth: SCO socket layer initialized
Apr 13 08:52:43 moode kernel: [   30.600127] Bluetooth: HCI UART driver ver 2.3
Apr 13 08:52:43 moode kernel: [   30.600141] Bluetooth: HCI UART protocol H4 registered
Apr 13 08:52:43 moode kernel: [   30.600208] Bluetooth: HCI UART protocol Three-wire (H5) registered
Apr 13 08:52:43 moode kernel: [   30.600449] Bluetooth: HCI UART protocol Broadcom registered
Apr 13 08:52:43 moode kernel: [   30.757406] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Apr 13 08:52:43 moode kernel: [   30.757413] Bluetooth: BNEP filters: protocol multicast
Apr 13 08:52:43 moode kernel: [   30.757425] Bluetooth: BNEP socket layer initialized
Apr 13 08:52:47 moode kernel: [   34.091262] FS-Cache: Netfs 'cifs' registered for caching
Apr 13 08:52:47 moode kernel: [   34.099641] Key type cifs.spnego registered
Apr 13 08:52:47 moode kernel: [   34.099653] Key type cifs.idmap registered
Apr 13 08:52:47 moode kernel: [   34.100375] CIFS: Attempting to mount //DISKSTATION/music

I have a power controller for the Rpi, that works kind of like this: http://moodeaudio.org/forum/showthread.php?tid=3627 post#5. From the shutdown is innitiated to the power is cut, it takes 90 seconds. After restart, I almost always get: "MPD error JSON.parse: unexpected end of data at line 1 column 1 of the JSON data" in the moode GUI 3-5 times right after bootup

Can anyone see any problems, that are related to the inability to shutdown from moode when BT has been used? and the MPD errors?

vinnn

04-13-2021, 08:45 AM
Both logs show a similar startup time upto mounting the network share, first is 35 seconds, second is slightly quicker at 34 seconds.
What are you actually seeing that shows it's not shutting down or taking a long time to shut down?
I tried exactly what you describe but can't replicate your issue with my Pi 3B+, GUI running in both Firefox & Chromium.

Max Schmeling

04-13-2021, 01:14 PM
Strange. I agree, the logs look like startup logs upon closer inspection, but the logs have been taken at the exact time, I shut down the system.

It doesn't seem  that I have any issues with boot, but shutdown, especially after I enable Bluetooth. How can I debug the shutdown process? and how can I debug the "Bluetooth issue"? when I enable Bluetooth, I can't shut down from the moode GUI, only by issuing "shutdown -P now" over ssh.
Pages: 1 2
Moode Forum > moOde audio player > Support > Bootup/shutdown issues, how to debug