-- Logs begin at Tue 2025-11-04 15:59:47 CET, end at Tue 2025-11-04 16:41:44 CET. -- Nov 04 16:40:25 hermanprimo go-librespot[3607]: time="2025-11-04T16:40:25+01:00" level=trace msg="received accesspoint ping" Nov 04 16:40:25 hermanprimo go-librespot[3607]: time="2025-11-04T16:40:25+01:00" level=trace msg="received accesspoint pong ack" Nov 04 16:40:25 hermanprimo go-librespot[3607]: time="2025-11-04T16:40:25+01:00" level=trace msg="sent dealer ping" Nov 04 16:40:25 hermanprimo go-librespot[3607]: time="2025-11-04T16:40:25+01:00" level=trace msg="received dealer pong" Nov 04 16:40:32 hermanprimo nmbd[3057]: [2025/11/04 16:40:32.377688, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Nov 04 16:40:32 hermanprimo nmbd[3057]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.188.76 for name WORKGROUP<1d>. Nov 04 16:40:32 hermanprimo nmbd[3057]: This response was from IP 192.168.188.22, reporting an IP address of 192.168.188.22. Nov 04 16:40:55 hermanprimo go-librespot[3607]: time="2025-11-04T16:40:55+01:00" level=trace msg="sent dealer ping" Nov 04 16:40:55 hermanprimo go-librespot[3607]: time="2025-11-04T16:40:55+01:00" level=trace msg="received dealer pong" Nov 04 16:40:58 hermanprimo volumio[3103]: info: Pushing metadata Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreCommandRouter::servicePushState Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreStateMachine::pushState Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreCommandRouter::volumioPushState Nov 04 16:40:58 hermanprimo volumio[3103]: info: MRS: Pushing multiroomSync output update for this device Nov 04 16:40:58 hermanprimo volumio[3103]: info: MRS: Pushing multiroomSync output Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreCommandRouter::servicePushState Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreStateMachine::pushState Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreCommandRouter::volumioPushState Nov 04 16:40:58 hermanprimo volumio[3103]: info: MRS: Pushing multiroomSync output update for this device Nov 04 16:40:58 hermanprimo volumio[3103]: info: MRS: Pushing multiroomSync output Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreCommandRouter::servicePushState Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreStateMachine::pushState Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreCommandRouter::volumioPushState Nov 04 16:40:58 hermanprimo volumio[3103]: info: MRS: Pushing multiroomSync output update for this device Nov 04 16:40:58 hermanprimo volumio[3103]: info: MRS: Pushing multiroomSync output Nov 04 16:40:58 hermanprimo volumio[3103]: info: Signalling Playback active due to playback status change Nov 04 16:40:58 hermanprimo volumio[3103]: info: Signalling Playback active due to playback status change Nov 04 16:40:58 hermanprimo volumio[3103]: info: Signalling Playback active due to playback status change Nov 04 16:40:58 hermanprimo volumio[3103]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Nov 04 16:40:58 hermanprimo volumio[3103]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Nov 04 16:40:58 hermanprimo volumio[3103]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Nov 04 16:40:58 hermanprimo volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 16:40:58 hermanprimo volumio[3103]: info: [now-playing] Fetch metadata (DefaultMetadataProvider): {"type":"song","name":"How Insensitive","artist":"Al Muirhead, Mike Murley, Chris Andrew","album":"Northern Adventures - The Canada Sessions, Vol. 1","duration":"330","uri":"","service":""} Nov 04 16:40:58 hermanprimo volumio[3103]: info: [now-playing] LRCLIB getLyrics(): song: "How Insensitive" album: "Northern Adventures - The Canada Sessions, Vol. 1" artist: "Al Muirhead, Mike Murley, Chris Andrew" duration: "330" Nov 04 16:40:58 hermanprimo volumio[3103]: info: [now-playing] LRCLIB getLyrics() API URL: https://lrclib.net/api/get?track_name=How+Insensitive&artist_name=Al+Muirhead%2C+Mike+Murley%2C+Chris+Andrew&album_name=Northern+Adventures+-+The+Canada+Sessions%2C+Vol.+1&duration=330 Nov 04 16:40:59 hermanprimo volumio[3103]: error: [now-playing] Error fetching lyrics from LRCLIB (URL: https://lrclib.net/api/get?track_name=How+Insensitive&artist_name=Al+Muirhead%2C+Mike+Murley%2C+Chris+Andrew&album_name=Northern+Adventures+-+The+Canada+Sessions%2C+Vol.+1&duration=330): Error: Response error: 404 - Not Found Nov 04 16:40:59 hermanprimo volumio[3103]: at apiGet (/data/plugins/user_interface/now_playing/dist/lib/api/lrclib/index.js:21:15) Nov 04 16:40:59 hermanprimo volumio[3103]: at runMicrotasks () Nov 04 16:40:59 hermanprimo volumio[3103]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Nov 04 16:40:59 hermanprimo volumio[3103]: at async Function.getLyrics (/data/plugins/user_interface/now_playing/dist/lib/api/lrclib/index.js:34:24) Nov 04 16:40:59 hermanprimo volumio[3103]: at async DefaultMetadataProvider.getSongInfo (/data/plugins/user_interface/now_playing/dist/lib/api/DefaultMetadataProvider.js:62:37) Nov 04 16:40:59 hermanprimo volumio[3103]: at async /data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:131:40 Nov 04 16:41:25 hermanprimo go-librespot[3607]: time="2025-11-04T16:41:25+01:00" level=trace msg="sent dealer ping" Nov 04 16:41:25 hermanprimo go-librespot[3607]: time="2025-11-04T16:41:25+01:00" level=trace msg="received dealer pong" Nov 04 16:41:43 hermanprimo volumio[3103]: info: CoreCommandRouter::volumioRemoveQueueItem Nov 04 16:41:43 hermanprimo volumio[3103]: info: CoreStateMachine::removeQueueItem Nov 04 16:41:43 hermanprimo volumio[3103]: info: CoreStateMachine::stop Nov 04 16:41:43 hermanprimo volumio[3103]: info: CoreStateMachine::serviceStop Nov 04 16:41:43 hermanprimo volumio[3103]: info: CoreCommandRouter::serviceStop Nov 04 16:41:43 hermanprimo volumio[3103]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 16:41:43 hermanprimo vtcs[3867]: [2025-11-04 16:41:43] [info] asio async_shutdown error: asio.misc:2 (End of file) Nov 04 16:41:43 hermanprimo vtcs[3867]: [close:85] Entering Nov 04 16:41:43 hermanprimo vtcs[3867]: [feedThread:276] Exiting Nov 04 16:41:43 hermanprimo vtcs[3867]: [close:100] Exiting Nov 04 16:41:43 hermanprimo volumio[3103]: TypeError: Cannot read property 'then' of undefined Nov 04 16:41:43 hermanprimo volumio[3103]: at CoreStateMachine.removeQueueItem (/volumio/app/statemachine.js:1370:7) Nov 04 16:41:43 hermanprimo volumio[3103]: at CoreCommandRouter.volumioRemoveQueueItem (/volumio/app/index.js:121:28) Nov 04 16:41:43 hermanprimo volumio[3103]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:173:33) Nov 04 16:41:43 hermanprimo volumio[3103]: at Socket.emit (events.js:400:28) Nov 04 16:41:43 hermanprimo volumio[3103]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 04 16:41:43 hermanprimo volumio[3103]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Nov 04 16:41:43 hermanprimo volumio[3103]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 16:41:44 hermanprimo sudo[10299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-04 16:40 Nov 04 16:41:44 hermanprimo sudo[10299]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="primo2rev2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 12:21:26 PM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Primo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Primo" VOLUMIO_HASH="0f77ca7c94b84efc5e990804c1669257"