08-03-2022, 12:12 PM
(This post was last modified: 08-03-2022, 12:13 PM by Tim Curtis.
Edit Reason: Formatting
)
There are definitely some suspicious timings in the log. Typically moOde startup which occurs after Linux startup and is recorded in the moOde startup log takes around 30 - 60 seconds.
The log you posted shows that moOde startup took 4 minutes 22 seconds :-0
There are 3 long delays in the log. Two of these delays marked A and B below occur during sections where various files are being updated. The third delay marked C occurs when the watchdog script is launched.
The delays account for around 3 minutes 30 seconds which if subtracted from the total startup time bring it down to around 1 minute. I suspect that Linux startup which is recorded in the dmesg log would also show some unusual delays.
The delays suggest possible slow or malfunctioning boot media (SD Card or USB drive).
Delays are marked in red.
pi@moode:~ $ moodeutl -l
20220802 031041 worker: --
20220802 031041 worker: -- Start moOde 8 series
20220802 031041 worker: --
20220802 031041 worker: Successfully daemonized
A - 2 minutes
20220802 031242 worker: File check (OK)
20220802 031242 worker: Session vacuumed
20220802 031242 worker: Session loaded
20220802 031242 worker: Debug logging (OFF)
20220802 031242 worker: --
20220802 031242 worker: -- Audio debug
20220802 031242 worker: --
20220802 031242 worker: ALSA cards: (0:Boss2 | 1:empty | 2:empty | 3:empty
20220802 031242 worker: MPD config: (0:Allo Boss 2 DAC | mixer(Master) | card:0)
20220802 031242 worker: ALSA mixer actual (Master)
20220802 031242 worker: ALSA Master volume set to (0%)
20220802 031242 worker: --
20220802 031242 worker: -- System
20220802 031242 worker: --
20220802 031244 worker: Host (moode)
20220802 031244 worker: moOde (8.1.2 2022-07-08)
20220802 031244 worker: RaspiOS (11.3)
20220802 031244 worker: Kernel (5.15.32-v8+ #1538)
20220802 031244 worker: Platform (Pi-4B 1.4 4GB)
20220802 031244 worker: ARM arch (aarch64, 64-bit)
20220802 031244 worker: MPD ver (0.23.5)
20220802 031244 worker: CPU gov (ondemand)
20220802 031244 worker: USB boot (enabled)
20220802 031244 worker: File sys (expanded)
20220802 031244 worker: HDMI port (Off)
20220802 031245 worker: Sys LED0 (On)
20220802 031245 worker: Sys LED1 (On)
20220802 031245 worker: --
20220802 031245 worker: -- Network
20220802 031245 worker: --
20220802 031245 worker: eth0 adapter exists
20220802 031245 worker: eth0 check for address (No)
20220802 031245 worker: eth0 address not assigned
20220802 031245 worker: wlan0 adapter exists
20220802 031245 worker: wlan0 country (IN)
20220802 031245 worker: wlan0 connected SSID is (Home-WiFi)
20220802 031245 worker: IP addr (10.0.0.8)
20220802 031245 worker: Netmask (255.255.255.0)
20220802 031245 worker: Gateway (10.0.0.1)
20220802 031245 worker: Pri DNS (10.0.0.1)
20220802 031245 worker: Domain ()
20220802 031246 worker: wlan0 power save disabled
20220802 031246 worker: --
20220802 031246 worker: -- Audio config
20220802 031246 worker: --
B - 1 minute
20220802 031341 worker: MPD conf updated
20220802 031341 worker: ALSA card number (0)
20220802 031341 worker: MPD audio output (Allo Boss 2 DAC)
20220802 031344 worker: Audio formats (S16_LE, S24_LE, S32_LE)
20220802 031344 worker: ALSA mixer name (Master)
20220802 031344 worker: MPD mixer type (software)
20220802 031344 worker: Hdwr volume controller exists
20220802 031344 worker: Max ALSA volume (100%)
20220802 031344 worker: ALSA output mode (Default: plughw)
20220802 031344 worker: ALSA loopback (Off)
20220802 031344 worker: Boss 2 OLED started
20220802 031344 worker: Reset renderer active flags
20220802 031344 worker: CamillaDSP (off)
20220802 031344 worker: --
20220802 031344 worker: -- MPD startup
20220802 031344 worker: --
20220802 031344 worker: MPD started
20220802 031344 worker: MPD accepting connections
20220802 031344 worker: MPD output 1 ALSA Default (On)
20220802 031344 worker: MPD output 2 ALSA Bluetooth (Off)
20220802 031344 worker: MPD output 3 HTTP Server (Off)
20220802 031344 worker: MPD crossfade (off)
20220802 031344 worker: MPD ignore CUE files (yes)
20220802 031344 worker: Default playlist loaded for first boot
20220802 031344 worker: --
20220802 031344 worker: -- Music sources
20220802 031344 worker: --
20220802 031344 worker: USB sources (none attached)
20220802 031344 worker: NAS sources (none configured)
20220802 031344 worker: --
20220802 031344 worker: -- Feature availability
20220802 031344 worker: --
20220802 031344 worker: Source select (available)
20220802 031344 worker: Source select (source: MPD)
20220802 031344 worker: Source select (output: Allo Boss 2 DAC)
20220802 031344 worker: Bluetooth (available)
20220802 031344 worker: Airplay renderer (available: started)
20220802 031344 worker: Spotify renderer (available)
20220802 031344 worker: Squeezelite (available)
20220802 031344 worker: RoonBridge renderer (not installed)
20220802 031344 worker: Multiroom sender (available)
20220802 031344 worker: Multiroom receiver (available)
20220802 031344 worker: UPnP renderer (available)
20220802 031344 worker: DLNA server (available)
20220802 031344 worker: GPIO button handler (available)
20220802 031344 worker: Stream recorder (n/a)
20220802 031344 worker: --
20220802 031344 worker: -- Other
20220802 031344 worker: --
20220802 031344 worker: USB volume knob (Off)
20220802 031344 worker: Shellinabox SSH started
20220802 031344 worker: USB auto-mounter (udisks-glue)
20220802 031344 worker: Saved MPD vol level (0)
20220802 031344 worker: Preamp volume level (0)
20220802 031344 worker: MPD volume level (0) restored
20220802 031344 worker: ALSA Master volume (100%)
20220802 031344 worker: Auto-play (Off)
20220802 031344 worker: CoverView toggle (-off)
20220802 031344 worker: Maintenance interval (120 minutes)
20220802 031344 worker: Screen saver activation (Never)
20220802 031344 worker: Session permissions (OK)
20220802 031438 worker: Watchdog started
C - 25 seconds
20220802 031503 worker: Ready
The log you posted shows that moOde startup took 4 minutes 22 seconds :-0
There are 3 long delays in the log. Two of these delays marked A and B below occur during sections where various files are being updated. The third delay marked C occurs when the watchdog script is launched.
The delays account for around 3 minutes 30 seconds which if subtracted from the total startup time bring it down to around 1 minute. I suspect that Linux startup which is recorded in the dmesg log would also show some unusual delays.
The delays suggest possible slow or malfunctioning boot media (SD Card or USB drive).
Delays are marked in red.
pi@moode:~ $ moodeutl -l
20220802 031041 worker: --
20220802 031041 worker: -- Start moOde 8 series
20220802 031041 worker: --
20220802 031041 worker: Successfully daemonized
A - 2 minutes
20220802 031242 worker: File check (OK)
20220802 031242 worker: Session vacuumed
20220802 031242 worker: Session loaded
20220802 031242 worker: Debug logging (OFF)
20220802 031242 worker: --
20220802 031242 worker: -- Audio debug
20220802 031242 worker: --
20220802 031242 worker: ALSA cards: (0:Boss2 | 1:empty | 2:empty | 3:empty
20220802 031242 worker: MPD config: (0:Allo Boss 2 DAC | mixer(Master) | card:0)
20220802 031242 worker: ALSA mixer actual (Master)
20220802 031242 worker: ALSA Master volume set to (0%)
20220802 031242 worker: --
20220802 031242 worker: -- System
20220802 031242 worker: --
20220802 031244 worker: Host (moode)
20220802 031244 worker: moOde (8.1.2 2022-07-08)
20220802 031244 worker: RaspiOS (11.3)
20220802 031244 worker: Kernel (5.15.32-v8+ #1538)
20220802 031244 worker: Platform (Pi-4B 1.4 4GB)
20220802 031244 worker: ARM arch (aarch64, 64-bit)
20220802 031244 worker: MPD ver (0.23.5)
20220802 031244 worker: CPU gov (ondemand)
20220802 031244 worker: USB boot (enabled)
20220802 031244 worker: File sys (expanded)
20220802 031244 worker: HDMI port (Off)
20220802 031245 worker: Sys LED0 (On)
20220802 031245 worker: Sys LED1 (On)
20220802 031245 worker: --
20220802 031245 worker: -- Network
20220802 031245 worker: --
20220802 031245 worker: eth0 adapter exists
20220802 031245 worker: eth0 check for address (No)
20220802 031245 worker: eth0 address not assigned
20220802 031245 worker: wlan0 adapter exists
20220802 031245 worker: wlan0 country (IN)
20220802 031245 worker: wlan0 connected SSID is (Home-WiFi)
20220802 031245 worker: IP addr (10.0.0.8)
20220802 031245 worker: Netmask (255.255.255.0)
20220802 031245 worker: Gateway (10.0.0.1)
20220802 031245 worker: Pri DNS (10.0.0.1)
20220802 031245 worker: Domain ()
20220802 031246 worker: wlan0 power save disabled
20220802 031246 worker: --
20220802 031246 worker: -- Audio config
20220802 031246 worker: --
B - 1 minute
20220802 031341 worker: MPD conf updated
20220802 031341 worker: ALSA card number (0)
20220802 031341 worker: MPD audio output (Allo Boss 2 DAC)
20220802 031344 worker: Audio formats (S16_LE, S24_LE, S32_LE)
20220802 031344 worker: ALSA mixer name (Master)
20220802 031344 worker: MPD mixer type (software)
20220802 031344 worker: Hdwr volume controller exists
20220802 031344 worker: Max ALSA volume (100%)
20220802 031344 worker: ALSA output mode (Default: plughw)
20220802 031344 worker: ALSA loopback (Off)
20220802 031344 worker: Boss 2 OLED started
20220802 031344 worker: Reset renderer active flags
20220802 031344 worker: CamillaDSP (off)
20220802 031344 worker: --
20220802 031344 worker: -- MPD startup
20220802 031344 worker: --
20220802 031344 worker: MPD started
20220802 031344 worker: MPD accepting connections
20220802 031344 worker: MPD output 1 ALSA Default (On)
20220802 031344 worker: MPD output 2 ALSA Bluetooth (Off)
20220802 031344 worker: MPD output 3 HTTP Server (Off)
20220802 031344 worker: MPD crossfade (off)
20220802 031344 worker: MPD ignore CUE files (yes)
20220802 031344 worker: Default playlist loaded for first boot
20220802 031344 worker: --
20220802 031344 worker: -- Music sources
20220802 031344 worker: --
20220802 031344 worker: USB sources (none attached)
20220802 031344 worker: NAS sources (none configured)
20220802 031344 worker: --
20220802 031344 worker: -- Feature availability
20220802 031344 worker: --
20220802 031344 worker: Source select (available)
20220802 031344 worker: Source select (source: MPD)
20220802 031344 worker: Source select (output: Allo Boss 2 DAC)
20220802 031344 worker: Bluetooth (available)
20220802 031344 worker: Airplay renderer (available: started)
20220802 031344 worker: Spotify renderer (available)
20220802 031344 worker: Squeezelite (available)
20220802 031344 worker: RoonBridge renderer (not installed)
20220802 031344 worker: Multiroom sender (available)
20220802 031344 worker: Multiroom receiver (available)
20220802 031344 worker: UPnP renderer (available)
20220802 031344 worker: DLNA server (available)
20220802 031344 worker: GPIO button handler (available)
20220802 031344 worker: Stream recorder (n/a)
20220802 031344 worker: --
20220802 031344 worker: -- Other
20220802 031344 worker: --
20220802 031344 worker: USB volume knob (Off)
20220802 031344 worker: Shellinabox SSH started
20220802 031344 worker: USB auto-mounter (udisks-glue)
20220802 031344 worker: Saved MPD vol level (0)
20220802 031344 worker: Preamp volume level (0)
20220802 031344 worker: MPD volume level (0) restored
20220802 031344 worker: ALSA Master volume (100%)
20220802 031344 worker: Auto-play (Off)
20220802 031344 worker: CoverView toggle (-off)
20220802 031344 worker: Maintenance interval (120 minutes)
20220802 031344 worker: Screen saver activation (Never)
20220802 031344 worker: Session permissions (OK)
20220802 031438 worker: Watchdog started
C - 25 seconds
20220802 031503 worker: Ready