-- Logs begin at Fri 2026-08-28 12:53:05 CEST, end at Sun 2026-08-30 10:18:51 CEST. -- Aug 30 10:17:04 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:17:04 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:17:04 stue volumio[943]: info: Listing playlists Aug 30 10:17:04 stue volumio[943]: info: Listing playlists Aug 30 10:17:14 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:17:14 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:17:24 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:17:24 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:17:24 stue volumio[943]: info: Listing playlists Aug 30 10:17:24 stue volumio[943]: info: Listing playlists Aug 30 10:17:34 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:17:34 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:17:44 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:17:44 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:17:44 stue volumio[943]: info: Listing playlists Aug 30 10:17:44 stue volumio[943]: info: Listing playlists Aug 30 10:17:54 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:17:54 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:04 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:04 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:04 stue volumio[943]: info: Listing playlists Aug 30 10:18:04 stue volumio[943]: info: Listing playlists Aug 30 10:18:14 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:14 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:24 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:24 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:24 stue volumio[943]: info: Listing playlists Aug 30 10:18:24 stue volumio[943]: info: Listing playlists Aug 30 10:18:34 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:34 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:44 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:44 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:44 stue volumio[943]: info: Listing playlists Aug 30 10:18:44 stue volumio[943]: info: Listing playlists Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:50 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:50 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:50 stue volumio[943]: info: Currently active: webradio Aug 30 10:18:50 stue volumio[943]: info: Stopping currently active service Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::volumioStop Aug 30 10:18:50 stue volumio[943]: info: CoreStateMachine::stop Aug 30 10:18:50 stue volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 10:18:50 stue volumio[943]: info: TidalConnect Active Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:50 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:50 stue volumio[943]: info: Currently active: webradio Aug 30 10:18:50 stue volumio[943]: info: Setting Volatile state to tidalconnect Aug 30 10:18:50 stue volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::servicePushState Aug 30 10:18:50 stue volumio[943]: info: CoreStateMachine::pushState Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::volumioPushState Aug 30 10:18:50 stue volumio[943]: info: MRS: Pushing multiroomSync output update for this device Aug 30 10:18:50 stue volumio[943]: info: MRS: Pushing multiroomSync output Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:50 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:50 stue volumio[943]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::servicePushState Aug 30 10:18:50 stue volumio[943]: info: CoreStateMachine::pushState Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::volumioPushState Aug 30 10:18:50 stue volumio[943]: info: MRS: Pushing multiroomSync output update for this device Aug 30 10:18:50 stue volumio[943]: info: MRS: Pushing multiroomSync output Aug 30 10:18:50 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:50 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:50 stue volumio[943]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Aug 30 10:18:50 stue volumio5-onboarding[1334]: time=2026-08-30T10:18:50.584+02:00 level=WARN msg="received unknown player status" component=volumio status="" Aug 30 10:18:50 stue volumio5-onboarding[1334]: time=2026-08-30T10:18:50.585+02:00 level=WARN msg="received unknown player status" component=volumio status="" Aug 30 10:18:50 stue volumio[943]: info: [SERIALAMPCONTROLLER] on:pushState: {"status":"stop","position":0,"title":"DR P8 Jazz","albumart":"http://cdn-profiles.tunein.com/s36105/images/logoq.png","uri":"http://live-icy.gss.dr.dk/A/A22L.mp3.m3u","trackType":"webradio","seek":0,"samplerate":"","bitdepth":"","channels":0,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":54,"dbVolume":null,"mute":false,"stream":"webradio","updatedb":false,"volatile":false,"service":"webradio"} - Aug 30 10:18:50 stue volumio[943]: info: [SERIALAMPCONTROLLER] autoPowerOff: Aktivitet registreret — ingen auto-sluk Aug 30 10:18:50 stue volumio[943]: info: [SERIALAMPCONTROLLER] on:pushState: {"status":"","title":"","artist":"","albumart":"/albumart","trackType":"","codec":"","consume":false,"volume":54,"dbVolume":null,"mute":false,"stream":false,"updatedb":false,"volatile":true} - undefined Aug 30 10:18:50 stue volumio[943]: info: [SERIALAMPCONTROLLER] autoPowerOff: Aktivitet registreret — ingen auto-sluk Aug 30 10:18:50 stue volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 54 Aug 30 10:18:50 stue volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 54 Aug 30 10:18:50 stue volumio[943]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.OLGMfxEML4g1yRferfjECpLnqx82.79c50dcba907eb12c38c9c4ee6692f07.state.status' Aug 30 10:18:50 stue vtcs[2038]: [2026-08-30 10:18:50.940] [tisoc] [warning] [PlaybackControllerImpl.cpp:498] Illegal state:1 Aug 30 10:18:51 stue vtcs[2038]: [2026-08-30 10:18:51.122] [tisoc] [warning] [PlaybackControllerImpl.cpp:213] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0 Aug 30 10:18:51 stue volumio[943]: info: Pushing metadata Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::servicePushState Aug 30 10:18:51 stue volumio[943]: info: CoreStateMachine::pushState Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::volumioPushState Aug 30 10:18:51 stue volumio[943]: info: MRS: Pushing multiroomSync output update for this device Aug 30 10:18:51 stue volumio[943]: info: MRS: Pushing multiroomSync output Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:51 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:51 stue volumio[943]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Aug 30 10:18:51 stue volumio5-onboarding[1334]: time=2026-08-30T10:18:51.126+02:00 level=WARN msg="received unknown player status" component=volumio status="" Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::servicePushState Aug 30 10:18:51 stue volumio[943]: info: CoreStateMachine::pushState Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::volumioPushState Aug 30 10:18:51 stue volumio[943]: info: MRS: Pushing multiroomSync output update for this device Aug 30 10:18:51 stue volumio[943]: info: MRS: Pushing multiroomSync output Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:51 stue volumio[943]: info: CorePlayQueue::getTrack 0 Aug 30 10:18:51 stue volumio[943]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::servicePushState Aug 30 10:18:51 stue volumio[943]: info: CoreStateMachine::pushState Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::volumioPushState Aug 30 10:18:51 stue volumio[943]: info: MRS: Pushing multiroomSync output update for this device Aug 30 10:18:51 stue volumio[943]: info: MRS: Pushing multiroomSync output Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::servicePushState Aug 30 10:18:51 stue volumio[943]: info: CoreStateMachine::pushState Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::volumioPushState Aug 30 10:18:51 stue volumio[943]: info: MRS: Pushing multiroomSync output update for this device Aug 30 10:18:51 stue volumio[943]: info: MRS: Pushing multiroomSync output Aug 30 10:18:51 stue volumio[943]: info: CoreCommandRouter::volumioGetState Aug 30 10:18:51 stue volumio5-onboarding[1334]: time=2026-08-30T10:18:51.139+02:00 level=WARN msg="received unknown player status" component=volumio status="" Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] on:pushState: {"albumart":"/albumart","trackType":"","codec":"","consume":false,"volume":54,"dbVolume":null,"mute":false,"stream":false,"updatedb":false,"volatile":true} - undefined Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] autoPowerOff: Aktivitet registreret — ingen auto-sluk Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] on:pushState: {"albumart":"/albumart","trackType":"","codec":"","consume":false,"volume":54,"dbVolume":null,"mute":false,"stream":false,"updatedb":false,"volatile":true} - undefined Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] autoPowerOff: Aktivitet registreret — ingen auto-sluk Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] on:pushState: {"albumart":"/albumart","trackType":"","codec":"","consume":false,"volume":54,"dbVolume":null,"mute":false,"stream":false,"updatedb":false,"volatile":true} - pause Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] autoPowerOff: Aktivitet registreret — ingen auto-sluk Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] on:pushState: {"status":"pause","title":"Everything In Its Right Place","artist":"Radiohead","album":"Kid A","albumart":"https://resources.tidal.com/images/e61bc6a3/c321/410b/b842/838d49a2dc06/1280x1280.jpg","uri":"","trackType":"tidal","codec":"","seek":8749,"duration":251,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"repeat":false,"repeatSingle":false,"consume":false,"volume":54,"dbVolume":null,"mute":false,"stream":false,"updatedb":false,"volatile":true,"service":"tidalconnect"} - play Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] on:pushState: amp in standby Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] on:pushState: amp in standby - send powerup after play pressed Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] sendCommand: send powerOn Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: PWON\r Aug 30 10:18:51 stue volumio[943]: info: [SERIALAMPCONTROLLER] sendCommand: HEX: 50574f4e0d Aug 30 10:18:51 stue volumio[943]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 10:18:51 stue volumio[943]: TypeError: self.sendCommand(...).then(...).then(...).catch is not a function Aug 30 10:18:51 stue volumio[943]: at Socket. (/data/plugins/system_hardware/serialampcontroller/index.js:356:29) Aug 30 10:18:51 stue volumio[943]: at Socket.Emitter.emit (/data/plugins/system_hardware/serialampcontroller/node_modules/component-emitter/index.js:145:20) Aug 30 10:18:51 stue volumio[943]: at Socket.onevent (/data/plugins/system_hardware/serialampcontroller/node_modules/socket.io-client/lib/socket.js:278:10) Aug 30 10:18:51 stue volumio[943]: at Socket.onpacket (/data/plugins/system_hardware/serialampcontroller/node_modules/socket.io-client/lib/socket.js:236:12) Aug 30 10:18:51 stue volumio[943]: at Manager. (/data/plugins/system_hardware/serialampcontroller/node_modules/component-bind/index.js:21:15) Aug 30 10:18:51 stue volumio[943]: at Manager.Emitter.emit (/data/plugins/system_hardware/serialampcontroller/node_modules/component-emitter/index.js:145:20) Aug 30 10:18:51 stue volumio[943]: at Manager.ondecoded (/data/plugins/system_hardware/serialampcontroller/node_modules/socket.io-client/lib/manager.js:349:8) Aug 30 10:18:51 stue volumio[943]: at Decoder. (/data/plugins/system_hardware/serialampcontroller/node_modules/component-bind/index.js:21:15) Aug 30 10:18:51 stue volumio[943]: at Decoder.Emitter.emit (/data/plugins/system_hardware/serialampcontroller/node_modules/component-emitter/index.js:145:20) Aug 30 10:18:51 stue volumio[943]: at Decoder.add (/data/plugins/system_hardware/serialampcontroller/node_modules/socket.io-parser/index.js:254:12) Aug 30 10:18:51 stue volumio[943]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 10:18:51 stue sudo[19708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-30 10:17 Aug 30 10:18:51 stue sudo[19708]: 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="3dada8b1e619a5feb94867e0865ace17474d7bce" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="30045b259d1a704a832ca7c1460c1fdfa4b723f9" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Mar 2026 09:58:18 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="54b3518c7dd8feba4753e0ad124ce801"