02-06-2025, 05:39 PM
(This post was last modified: 02-06-2025, 11:20 PM by Tim Curtis.
Edit Reason: place log in code box for readability
)
Behaviour:
- Reboot moode device
- On Android phone, open Spotify app
- Tap on "Connect to a device" icon
- Devices are shown including the "Moode Spotify"
- Tap to "Moode Spotify" (It tries to connect for about 40 sec and it gives up. )
- Tap on "Connect to a device" icon again
- Devices are shown but the "Moode Spotify" device is MISSING
This was happening occasionally (once a month), but after update to the latest release the renderer is not working. The same behavior observed on other phones. Also tested form Macbook Spotify client. There, I do not even see the the moode device.
Kindly find debug log attached below. Anyone some idea?
Thank you
Log:
- Reboot moode device
- On Android phone, open Spotify app
- Tap on "Connect to a device" icon
- Devices are shown including the "Moode Spotify"
- Tap to "Moode Spotify" (It tries to connect for about 40 sec and it gives up. )
- Tap on "Connect to a device" icon again
- Devices are shown but the "Moode Spotify" device is MISSING
This was happening occasionally (once a month), but after update to the latest release the renderer is not working. The same behavior observed on other phones. Also tested form Macbook Spotify client. There, I do not even see the the moode device.
Kindly find debug log attached below. Anyone some idea?
Thank you
Log:
Code:
0250206 181520 worker: --
20250206 181520 worker: -- Start moOde 9 series
20250206 181520 worker: --
20250206 181520 worker: Daemonize: complete
20250206 181520 worker: Linux startup: complete
20250206 181520 worker: Boot config: ok
20250206 181520 worker: Boot folder: ok
20250206 181520 worker: Radio table: ok
20250206 181521 DEBUG: Maintenance: Purged spurious session file (sess_8hg8psct56a2ud3q1gguo2hl1o)
20250206 181521 worker: PHP session: cleaned
20250206 181521 DEBUG: phpSession(get_status): status=PHP_SESSION_NONE
20250206 181521 worker: PHP session: loaded
20250206 181523 worker: Package locks: applied
20250206 181524 worker: File check: complete
20250206 181524 worker: Log to RAM: on
20250206 181524 worker: Debug logging: on
20250206 181524 worker: --
20250206 181524 worker: -- System
20250206 181524 worker: --
20250206 181525 worker: Host name: moode
20250206 181525 worker: RPi model: Pi-4B 1.5 4GB
20250206 181525 worker: moOde release: 9.2.3 2025-01-21
20250206 181525 worker: RaspiOS: 12.8 Bookworm 64-bit
20250206 181525 worker: Linux Kernel: 6.6.62 64-bit
20250206 181525 worker: MPD version: 0.23.14
20250206 181525 worker: User id: pi
20250206 181525 worker: Home folder: /home/pi
20250206 181525 worker: Time zone: Europe/Prague
20250206 181525 worker: Kbd layout: us
20250206 181525 worker: HDMI ports(s): on
20250206 181525 worker: HDMI-CEC: off
20250206 181525 worker: Sys LED0: on
20250206 181525 worker: Sys LED1: on
20250206 181525 worker: Reduce power: n/a
20250206 181525 worker: Fan control: n/a
20250206 181525 worker: CPU governor: ondemand
20250206 181525 worker: Integ audio: vc4-kms-v3d
20250206 181525 worker: --
20250206 181525 worker: -- Network
20250206 181525 worker: --
20250206 181525 worker: Eth0
20250206 181525 worker: Ethernet: adapter exists
20250206 181525 worker: Ethernet: timeout off
20250206 181525 worker: Ethernet: address not assigned
20250206 181525 worker: Wlan0
20250206 181525 worker: Wireless: adapter exists
20250206 181525 worker: Wireless: country CZ
20250206 181525 worker: Wireless: SSID tsitron
20250206 181525 worker: Wireless: other None
20250206 181525 worker: Wireless: timeout up to 90 secs
20250206 181525 worker: Wireless: connect to tsitron
20250206 181526 worker: Wireless: method dhcp
20250206 181526 worker: Wireless: address 192.168.1.119
20250206 181526 worker: Wireless: netmask 255.255.255.0
20250206 181526 worker: Wireless: gateway 192.168.1.1
20250206 181526 worker: Wireless: pri DNS 192.168.1.131
20250206 181526 worker: Wireless: domain none found
20250206 181526 worker: --
20250206 181526 worker: -- File sharing
20250206 181526 worker: --
20250206 181526 worker: SMB file sharing: off
20250206 181526 worker: SMB password: none
20250206 181526 worker: NFS file sharing: off
20250206 181526 worker: DLNA file sharing: off
20250206 181526 worker: --
20250206 181526 worker: -- Special configs
20250206 181526 worker: --
20250206 181526 worker: Plexamp: not installed
20250206 181526 worker: RoonBridge: not installed
20250206 181526 worker: Allo Boss 2: not detected, OLED script ok
20250206 181526 worker: Allo Piano 2.1: not detected
20250206 181526 worker: IQaudIO AMP*: not detected
20250206 181526 worker: Bluetooth: session vars ok
20250206 181526 worker: --
20250206 181526 worker: -- ALSA debug
20250206 181526 worker: --
20250206 181526 worker: Cards: 0:vc4hdmi0 1:Tone1 2:vc4hdmi1 3:empty
20250206 181526 worker: 4:empty 5:empty 6:empty 7:empty
20250206 181526 worker: Mixers: 0:none 1:(Tone1 ) 2:none 3:none
20250206 181526 worker: 4:none 5:none 6:none 7:none
20250206 181526 worker: --
20250206 181526 worker: -- Audio configuration
20250206 181526 worker: --
20250206 181526 worker: Audio device: 1:Tone1
20250206 181526 worker: ALSA card: has not been reassigned
20250206 181526 worker: MPD config: update not needed
20250206 181526 worker: ALSA output: USB
20250206 181526 worker: ALSA mode: Default (plughw)
20250206 181526 worker: ALSA mixer: Tone1
20250206 181526 worker: ALSA volume: 75% (-32.00dB)
20250206 181526 worker: ALSA maxvol: 60%
20250206 181526 worker: ALSA loopback: off
20250206 181526 worker: MPD mixer Hardware
20250206 181526 worker: Audio formats: S32_LE, SPECIAL, DSD_U32_BE
20250206 181526 worker: CamillaDSP: off
20250206 181526 worker: CDSP volume: 0dB
20250206 181526 worker: CDSP volrange: 60dB
20250206 181526 worker: --
20250206 181526 worker: -- MPD startup
20250206 181526 worker: --
20250206 181527 DEBUG: MPD|ALSA devnum: alsaequal|usb
20250206 181527 worker: MPD service: started
20250206 181527 worker: MPD port 6600: accepting connections
20250206 181527 worker: MPD ALSA Default: on
20250206 181527 worker: MPD ALSA Bluetooth: off
20250206 181527 worker: MPD HTTP Server: off
20250206 181527 worker: MPD volume: 29
20250206 181527 worker: Saved MPD vol: -1
20250206 181527 worker: Saved SRC vol: 0
20250206 181527 worker: MPD crossfade: off
20250206 181527 worker: MPD ignore CUE: no
20250206 181527 worker: MPD CDSP volsync: off
20250206 181527 worker: --
20250206 181527 worker: -- Music sources
20250206 181527 worker: --
20250206 181527 worker: USB drives: none
20250206 181527 worker: NVMe drives: none
20250206 181527 worker: SATA drives: none
20250206 181527 worker: NAS sources: none
20250206 181527 worker: --
20250206 181527 worker: -- Feature availability
20250206 181527 worker: --
20250206 181527 worker: Input select: available, Source: MPD, Output: Tone1
20250206 181529 worker: Bluetooth: started, PIN: Set, ALSA/CDSP maxvol: 60%/0dB, ALSA outmode: Standard
20250206 181529 worker: AirPlay: available
20250206 181529 DEBUG: startSpotify(): (librespot --name "Moode Spotify" --bitrate 320 --format S16 --mixer softvol --initial-volume 20 --volume-ctrl log --volume-range 60 --cache /var/local/www/spotify_cache --disable-audio-cache --backend alsa --device "_audioout" --onevent /var/local/www/commandw/spotevent.sh -v > /var/log/moode_librespot.log 2>&1 &)
20250206 181529 worker: Spotify Connect: started
20250206 181529 worker: Deezer Connect: available
20250206 181529 worker: Squeezelite: available
20250206 181529 worker: UPnP client: available
20250206 181529 worker: Plexamp: not installed, ALSA maxvol: 100%
20250206 181529 worker: RoonBridge: not installed
20250206 181529 worker: Multiroom: available
20250206 181529 worker: GPIO buttons: available
20250206 181529 worker: Stream recorder: n/a
20250206 181529 worker: --
20250206 181529 worker: -- Security
20250206 181529 worker: --
20250206 181529 worker: Web SSH server: off
20250206 181529 worker: XSS detection: off
20250206 181529 worker: HTTPS mode: available
20250206 181529 worker: --
20250206 181529 worker: -- Peripherals
20250206 181529 worker: --
20250206 181531 worker: Local display: off
20250206 181531 worker: Chromium ver: 126.0.6478.164-rpt1
20250206 181531 worker: Chromium cfg: directory ok
20250206 181531 worker: Screen blank 600
20250206 181531 worker: On-screen kbd: off
20250206 181531 worker: Disable GPU: off
20250206 181531 worker: HDMI orient: landscape
20250206 181531 worker: HDMI 4K 60Hz: off
20250206 181531 worker: DSI scn type: none
20250206 181531 worker: DSI port: 1
20250206 181531 worker: DSI brightness: 255
20250206 181531 worker: DSI rotate: 0
20250206 181531 worker: Rotary encoder: off
20250206 181531 worker: USB volume knob: off
20250206 181531 worker: LCD updater: off
20250206 181531 worker: --
20250206 181531 worker: -- Miscellaneous
20250206 181531 worker: --
20250206 181531 worker: Software update: Automatic check off
20250206 181531 worker: Auto-CoverView: off
20250206 181531 worker: CoverView timeout: Never
20250206 181531 worker: Auto-shuffle: off
20250206 181531 worker: Auto-play: off
20250206 181531 worker: Maintenance task: 360 mins
20250206 181531 worker: Current view: reset to Playback
20250206 181531 worker: Active flags: all false
20250206 181531 worker: Reset flags: skipped
20250206 181531 worker: Session check: ok
20250206 181531 worker: --
20250206 181531 worker: -- Startup complete
20250206 181531 worker: --
20250206 181532 worker: Mount monitor: started
20250206 181532 worker: Radio monitor: off
20250206 181532 worker: Watchdog monitor: started
20250206 181532 worker: Responsiveness: Default
20250206 181532 DEBUG: Sleep intervals: worker=3, waitworker=1, watchdog=6, mountmon=30, mpdmon=6, gpiobuttons=1
20250206 181532 worker: Ready
20250206 181833 watchdog: Started Spotify Connect after crash detected
20250206 181837 DEBUG: startSpotify(): (librespot --name "Moode Spotify" --bitrate 320 --format S16 --mixer softvol --initial-volume 20 --volume-ctrl log --volume-range 60 --cache /var/local/www/spotify_cache --disable-audio-cache --backend alsa --device "_audioout" --onevent /var/local/www/commandw/spotevent.sh -v > /var/log/moode_librespot.log 2>&1 &)
20250206 182001 watchdog: Started Spotify Connect after crash detected
20250206 182005 DEBUG: startSpotify(): (librespot --name "Moode Spotify" --bitrate 320 --format S16 --mixer softvol --initial-volume 20 --volume-ctrl log --volume-range 60 --cache /var/local/www/spotify_cache --disable-audio-cache --backend alsa --device "_audioout" --onevent /var/local/www/commandw/spotevent.sh -v > /var/log/moode_librespot.log 2>&1 &)
20250206 182123 watchdog: Started Spotify Connect after crash detected
20250206 182127 DEBUG: startSpotify(): (librespot --name "Moode Spotify" --bitrate 320 --format S16 --mixer softvol --initial-volume 20 --volume-ctrl log --volume-range 60 --cache /var/local/www/spotify_cache --disable-audio-cache --backend alsa --device "_audioout" --onevent /var/local/www/commandw/spotevent.sh -v > /var/log/moode_librespot.log 2>&1 &)
20250206 182245 watchdog: Started Spotify Connect after crash detected
20250206 182245 DEBUG: startSpotify(): (librespot --name "Moode Spotify" --bitrate 320 --format S16 --mixer softvol --initial-volume 20 --volume-ctrl log --volume-range 60 --cache /var/local/www/spotify_cache --disable-audio-cache --backend alsa --device "_audioout" --onevent /var/local/www/commandw/spotevent.sh -v > /var/log/moode_librespot.log 2>&1 &)
20250206 182403 watchdog: Started Spotify Connect after crash detected
20250206 182403 DEBUG: startSpotify(): (librespot --name "Moode Spotify" --bitrate 320 --format S16 --mixer softvol --initial-volume 20 --volume-ctrl log --volume-range 60 --cache /var/local/www/spotify_cache --disable-audio-cache --backend alsa --device "_audioout" --onevent /var/local/www/commandw/spotevent.sh -v > /var/log/moode_librespot.log 2>&1 &)
20250206 182521 watchdog: Started Spotify Connect after crash detected
20250206 182521 DEBUG: startSpotify(): (librespot --name "Moode Spotify" --bitrate 320 --format S16 --mixer softvol --initial-volume 20 --volume-ctrl log --volume-range 60 --cache /var/local/www/spotify_cache --disable-audio-cache --backend alsa --device "_audioout" --onevent /var/local/www/commandw/spotevent.sh -v > /var/log/moode_librespot.log 2>&1 &)