-- Logs begin at Thu 2025-12-25 19:37:10 CET, end at Thu 2025-12-25 20:12:49 CET. --
Dec 25 20:12:08 badradio volumio[799]: info: CoreCommandRouter::volumioPlay
Dec 25 20:12:08 badradio volumio[799]: info: CoreStateMachine::play index undefined
Dec 25 20:12:08 badradio volumio[799]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 25 20:12:08 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:08 badradio volumio[799]: info: CoreStateMachine::startPlaybackTimer
Dec 25 20:12:08 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:08 badradio volumio[799]: info: [1766689928702] ControllerUPNPBrowser::clearAddPlayTrack
Dec 25 20:12:08 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand stop
Dec 25 20:12:08 badradio volumio[799]: info: sendMpdCommand stop took 54 milliseconds
Dec 25 20:12:08 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand clear
Dec 25 20:12:08 badradio volumio[799]: info: sendMpdCommand clear took 45 milliseconds
Dec 25 20:12:08 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3"
Dec 25 20:12:08 badradio volumio[799]: info:
Dec 25 20:12:08 badradio volumio[799]: ---------------------------- MPD announces system playlist update
Dec 25 20:12:08 badradio volumio[799]: info: Ignoring MPD Status Update
Dec 25 20:12:08 badradio volumio[799]: info:
Dec 25 20:12:08 badradio volumio[799]: ---------------------------- MPD announces system playlist update
Dec 25 20:12:08 badradio volumio[799]: info: Ignoring MPD Status Update
Dec 25 20:12:08 badradio volumio[799]: info:
Dec 25 20:12:08 badradio volumio[799]: ---------------------------- MPD announces system playlist update
Dec 25 20:12:08 badradio volumio[799]: info: Ignoring MPD Status Update
Dec 25 20:12:09 badradio volumio[799]: error: Upnp client error: Error: This socket has been ended by the other party
Dec 25 20:12:10 badradio volumio[799]: error: updateQueue error: null
Dec 25 20:12:10 badradio volumio[799]: error: updateQueue error: null
Dec 25 20:12:10 badradio volumio[799]: error: updateQueue error: null
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3"
Dec 25 20:12:10 badradio volumio[799]: info: ------------------------------ 1317ms
Dec 25 20:12:10 badradio volumio[799]: info: ------------------------------ 1262ms
Dec 25 20:12:10 badradio volumio[799]: info: ------------------------------ 1245ms
Dec 25 20:12:10 badradio volumio[799]: info:
Dec 25 20:12:10 badradio volumio[799]: ---------------------------- MPD announces system playlist update
Dec 25 20:12:10 badradio volumio[799]: info: Ignoring MPD Status Update
Dec 25 20:12:10 badradio volumio[799]: info: sendMpdCommand add "http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3" took 31 milliseconds
Dec 25 20:12:10 badradio volumio[799]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand play
Dec 25 20:12:10 badradio volumio[799]: info:
Dec 25 20:12:10 badradio volumio[799]: ---------------------------- MPD announces system playlist update
Dec 25 20:12:10 badradio volumio[799]: info: Ignoring MPD Status Update
Dec 25 20:12:10 badradio volumio[799]: info:
Dec 25 20:12:10 badradio volumio[799]: ---------------------------- MPD announces system playlist update
Dec 25 20:12:10 badradio volumio[799]: info: Ignoring MPD Status Update
Dec 25 20:12:10 badradio volumio[799]: info: ------------------------------ 243ms
Dec 25 20:12:10 badradio volumio[799]: info: sendMpdCommand play took 224 milliseconds
Dec 25 20:12:10 badradio volumio[799]: info: ------------------------------ 202ms
Dec 25 20:12:10 badradio volumio[799]: info: ------------------------------ 191ms
Dec 25 20:12:10 badradio volumio[799]: info:
Dec 25 20:12:10 badradio volumio[799]: ---------------------------- MPD announces state update: player
Dec 25 20:12:10 badradio volumio[799]: info: ControllerMpd::getState
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 20:12:10 badradio volumio[799]: info:
Dec 25 20:12:10 badradio volumio[799]: ---------------------------- MPD announces state update: player
Dec 25 20:12:10 badradio volumio[799]: info: ControllerMpd::getState
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 20:12:10 badradio volumio[799]: info:
Dec 25 20:12:10 badradio volumio[799]: ---------------------------- MPD announces state update: player
Dec 25 20:12:10 badradio volumio[799]: info: ControllerMpd::getState
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 20:12:10 badradio volumio[799]: info: sendMpdCommand status took 229 milliseconds
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::parseState
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 20:12:10 badradio volumio[799]: info:
Dec 25 20:12:10 badradio volumio[799]: ---------------------------- MPD announces state update: player
Dec 25 20:12:10 badradio volumio[799]: info: ControllerMpd::getState
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 20:12:10 badradio volumio[799]: info: sendMpdCommand status took 217 milliseconds
Dec 25 20:12:10 badradio volumio[799]: info: sendMpdCommand status took 229 milliseconds
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::parseState
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::parseState
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 20:12:10 badradio volumio[799]: info:
Dec 25 20:12:10 badradio volumio[799]: ---------------------------- MPD announces state update: player
Dec 25 20:12:10 badradio volumio[799]: info: ControllerMpd::getState
Dec 25 20:12:10 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 20:12:10 badradio volumio[799]: info:
Dec 25 20:12:10 badradio volumio[799]: ---------------------------- MPD announces state update: player
Dec 25 20:12:11 badradio volumio[799]: info: ControllerMpd::getState
Dec 25 20:12:11 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 20:12:11 badradio volumio[799]: info:
Dec 25 20:12:11 badradio volumio[799]: ---------------------------- MPD announces system playlist update
Dec 25 20:12:11 badradio volumio[799]: info: Ignoring MPD Status Update
Dec 25 20:12:11 badradio volumio[799]: info:
Dec 25 20:12:11 badradio volumio[799]: ---------------------------- MPD announces state update: player
Dec 25 20:12:11 badradio volumio[799]: info: sendMpdCommand playlistinfo took 158 milliseconds
Dec 25 20:12:11 badradio volumio[799]: info: sendMpdCommand status took 148 milliseconds
Dec 25 20:12:11 badradio volumio[799]: info: sendMpdCommand playlistinfo took 113 milliseconds
Dec 25 20:12:11 badradio volumio[799]: info: sendMpdCommand playlistinfo took 128 milliseconds
Dec 25 20:12:11 badradio volumio[799]: info: sendMpdCommand status took 104 milliseconds
Dec 25 20:12:11 badradio volumio[799]: info: ControllerMpd::getState
Dec 25 20:12:11 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 20:12:11 badradio volumio[799]: verbose: ControllerMpd::parseTrackInfo
Dec 25 20:12:11 badradio volumio[799]: verbose: ControllerMpd::parseState
Dec 25 20:12:11 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 20:12:11 badradio volumio[799]: verbose: ControllerMpd::parseTrackInfo
Dec 25 20:12:11 badradio volumio[799]: verbose: ControllerMpd::parseState
Dec 25 20:12:11 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 20:12:11 badradio volumio[799]: info: ControllerMpd::pushState
Dec 25 20:12:11 badradio volumio[799]: info: CoreCommandRouter::servicePushState
Dec 25 20:12:11 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:11 badradio volumio[799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mpeg,pn=MP3,ext=.mp3","artist":null,"album":null,"uri":"http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"}
Dec 25 20:12:11 badradio volumio[799]: verbose: CURRENT POSITION 0
Dec 25 20:12:11 badradio volumio[799]: info: CoreStateMachine::syncState stateService play
Dec 25 20:12:11 badradio volumio[799]: info: CoreStateMachine::syncState currentStatus stop
Dec 25 20:12:11 badradio volumio[799]: info: ControllerMpd::pushState
Dec 25 20:12:11 badradio volumio[799]: info: CoreCommandRouter::servicePushState
Dec 25 20:12:11 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:11 badradio volumio[799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mpeg,pn=MP3,ext=.mp3","artist":null,"album":null,"uri":"http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"}
Dec 25 20:12:11 badradio volumio[799]: verbose: CURRENT POSITION 0
Dec 25 20:12:11 badradio volumio[799]: info: CoreStateMachine::syncState stateService play
Dec 25 20:12:11 badradio volumio[799]: info: CoreStateMachine::syncState currentStatus play
Dec 25 20:12:11 badradio volumio[799]: info: Received an update from plugin. extracting info from payload
Dec 25 20:12:11 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:11 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 25 20:12:11 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:11 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:11 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:11 badradio volumio[799]: info: ControllerMpd::pushState
Dec 25 20:12:11 badradio volumio[799]: info: CoreCommandRouter::servicePushState
Dec 25 20:12:11 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:11 badradio volumio[799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mpeg,pn=MP3,ext=.mp3","artist":null,"album":null,"uri":"http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"}
Dec 25 20:12:11 badradio volumio[799]: verbose: CURRENT POSITION 0
Dec 25 20:12:11 badradio volumio[799]: info: CoreStateMachine::syncState stateService play
Dec 25 20:12:11 badradio volumio[799]: info: CoreStateMachine::syncState currentStatus play
Dec 25 20:12:11 badradio volumio[799]: info: Received an update from plugin. extracting info from payload
Dec 25 20:12:11 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:11 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:11 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:11 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:11 badradio volumio[799]: info: ------------------------------ 1168ms
Dec 25 20:12:12 badradio volumio[799]: info: ------------------------------ 1664ms
Dec 25 20:12:12 badradio volumio[799]: info: ------------------------------ 1624ms
Dec 25 20:12:12 badradio volumio[799]: info:
Dec 25 20:12:12 badradio volumio[799]: ---------------------------- MPD announces system playlist update
Dec 25 20:12:12 badradio volumio[799]: info: Ignoring MPD Status Update
Dec 25 20:12:12 badradio volumio[799]: info:
Dec 25 20:12:12 badradio volumio[799]: ---------------------------- MPD announces state update: player
Dec 25 20:12:12 badradio volumio[799]: info: ControllerMpd::getState
Dec 25 20:12:12 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 20:12:12 badradio volumio[799]: info:
Dec 25 20:12:12 badradio volumio[799]: ---------------------------- MPD announces system playlist update
Dec 25 20:12:12 badradio volumio[799]: info: Ignoring MPD Status Update
Dec 25 20:12:12 badradio volumio[799]: info:
Dec 25 20:12:12 badradio volumio[799]: ---------------------------- MPD announces state update: player
Dec 25 20:12:12 badradio volumio[799]: info: ControllerMpd::getState
Dec 25 20:12:12 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 20:12:12 badradio volumio[799]: info: sendMpdCommand status took 1874 milliseconds
Dec 25 20:12:12 badradio volumio[799]: info: ------------------------------ 1870ms
Dec 25 20:12:12 badradio volumio[799]: info: sendMpdCommand status took 1874 milliseconds
Dec 25 20:12:12 badradio volumio[799]: info: sendMpdCommand playlistinfo took 1822 milliseconds
Dec 25 20:12:13 badradio volumio[799]: info: sendMpdCommand playlistinfo took 1830 milliseconds
Dec 25 20:12:13 badradio volumio[799]: info: ------------------------------ 665ms
Dec 25 20:12:13 badradio volumio[799]: info: sendMpdCommand status took 417 milliseconds
Dec 25 20:12:13 badradio volumio[799]: info: ------------------------------ 380ms
Dec 25 20:12:13 badradio volumio[799]: info: sendMpdCommand status took 289 milliseconds
Dec 25 20:12:13 badradio volumio[799]: verbose: ControllerMpd::parseState
Dec 25 20:12:13 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 20:12:13 badradio volumio[799]: verbose: ControllerMpd::parseState
Dec 25 20:12:13 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 20:12:13 badradio volumio[799]: verbose: ControllerMpd::parseTrackInfo
Dec 25 20:12:13 badradio volumio[799]: verbose: ControllerMpd::parseTrackInfo
Dec 25 20:12:13 badradio volumio[799]: verbose: ControllerMpd::parseState
Dec 25 20:12:13 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 20:12:13 badradio volumio[799]: verbose: ControllerMpd::parseState
Dec 25 20:12:13 badradio volumio[799]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 20:12:13 badradio volumio[799]: info: ControllerMpd::pushState
Dec 25 20:12:13 badradio volumio[799]: info: CoreCommandRouter::servicePushState
Dec 25 20:12:13 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:13 badradio volumio[799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Das Wesen Der Glut","artist":"Dota","album":"Wo soll ich suchen","uri":"http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"}
Dec 25 20:12:13 badradio volumio[799]: verbose: CURRENT POSITION 0
Dec 25 20:12:13 badradio volumio[799]: info: CoreStateMachine::syncState stateService play
Dec 25 20:12:13 badradio volumio[799]: info: CoreStateMachine::syncState currentStatus play
Dec 25 20:12:13 badradio volumio[799]: info: Received an update from plugin. extracting info from payload
Dec 25 20:12:13 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:13 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 25 20:12:13 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:13 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:13 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:13 badradio volumio[799]: info: ControllerMpd::pushState
Dec 25 20:12:13 badradio volumio[799]: info: CoreCommandRouter::servicePushState
Dec 25 20:12:13 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:13 badradio volumio[799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Das Wesen Der Glut","artist":"Dota","album":"Wo soll ich suchen","uri":"http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"}
Dec 25 20:12:13 badradio volumio[799]: verbose: CURRENT POSITION 0
Dec 25 20:12:13 badradio volumio[799]: info: CoreStateMachine::syncState stateService play
Dec 25 20:12:13 badradio volumio[799]: info: CoreStateMachine::syncState currentStatus play
Dec 25 20:12:13 badradio volumio[799]: info: Received an update from plugin. extracting info from payload
Dec 25 20:12:13 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:13 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:13 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:13 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:14 badradio volumio[799]: info: ------------------------------ 3650ms
Dec 25 20:12:14 badradio volumio[799]: info: ------------------------------ 3636ms
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:15 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:15 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:15 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:15 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:15 badradio volumio[799]: info: sendMpdCommand playlistinfo took 2654 milliseconds
Dec 25 20:12:15 badradio volumio[799]: info: sendMpdCommand playlistinfo took 2523 milliseconds
Dec 25 20:12:15 badradio volumio[799]: info: sendMpdCommand playlistinfo took 2503 milliseconds
Dec 25 20:12:15 badradio volumio[799]: info: sendMpdCommand playlistinfo took 2493 milliseconds
Dec 25 20:12:15 badradio volumio[799]: verbose: ControllerMpd::parseTrackInfo
Dec 25 20:12:15 badradio volumio[799]: verbose: ControllerMpd::parseTrackInfo
Dec 25 20:12:15 badradio volumio[799]: verbose: ControllerMpd::parseTrackInfo
Dec 25 20:12:15 badradio volumio[799]: info: ControllerMpd::pushState
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::servicePushState
Dec 25 20:12:15 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:15 badradio volumio[799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":137,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Das Wesen Der Glut","artist":"Dota","album":"Wo soll ich suchen","uri":"http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"}
Dec 25 20:12:15 badradio volumio[799]: verbose: CURRENT POSITION 0
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::syncState stateService play
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::syncState currentStatus play
Dec 25 20:12:15 badradio volumio[799]: info: Received an update from plugin. extracting info from payload
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:15 badradio volumio[799]: info: ControllerMpd::pushState
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::servicePushState
Dec 25 20:12:15 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:15 badradio volumio[799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Das Wesen Der Glut","artist":"Dota","album":"Wo soll ich suchen","uri":"http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"}
Dec 25 20:12:15 badradio volumio[799]: verbose: CURRENT POSITION 0
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::syncState stateService play
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::syncState currentStatus play
Dec 25 20:12:15 badradio volumio[799]: info: Received an update from plugin. extracting info from payload
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:15 badradio volumio[799]: info: ControllerMpd::pushState
Dec 25 20:12:15 badradio volumio[799]: info: CoreCommandRouter::servicePushState
Dec 25 20:12:15 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:15 badradio volumio[799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2377,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Das Wesen Der Glut","artist":"Dota","album":"Wo soll ich suchen","uri":"http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"}
Dec 25 20:12:15 badradio volumio[799]: verbose: CURRENT POSITION 0
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::syncState stateService play
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::syncState currentStatus play
Dec 25 20:12:15 badradio volumio[799]: info: Received an update from plugin. extracting info from payload
Dec 25 20:12:15 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:16 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 25 20:12:16 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:16 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:16 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:16 badradio volumio[799]: info: ControllerMpd::pushState
Dec 25 20:12:16 badradio volumio[799]: info: CoreCommandRouter::servicePushState
Dec 25 20:12:16 badradio volumio[799]: info: CorePlayQueue::getTrack 0
Dec 25 20:12:16 badradio volumio[799]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2479,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Das Wesen Der Glut","artist":"Dota","album":"Wo soll ich suchen","uri":"http://192.168.178.39:8200/MediaItems/A0$128$146$20906261$45678869$76349717$76480789$800194820.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"}
Dec 25 20:12:16 badradio volumio[799]: verbose: CURRENT POSITION 0
Dec 25 20:12:16 badradio volumio[799]: info: CoreStateMachine::syncState stateService play
Dec 25 20:12:16 badradio volumio[799]: info: CoreStateMachine::syncState currentStatus play
Dec 25 20:12:16 badradio volumio[799]: info: Received an update from plugin. extracting info from payload
Dec 25 20:12:16 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:16 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 25 20:12:16 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:16 badradio volumio[799]: info: CoreStateMachine::pushState
Dec 25 20:12:16 badradio volumio[799]: info: CoreCommandRouter::volumioPushState
Dec 25 20:12:17 badradio volumio[799]: info: ------------------------------ 6031ms
Dec 25 20:12:17 badradio volumio[799]: info: ------------------------------ 5994ms
Dec 25 20:12:17 badradio volumio[799]: info: ------------------------------ 4662ms
Dec 25 20:12:17 badradio volumio[799]: info: ------------------------------ 4350ms
Dec 25 20:12:17 badradio volumio[799]: Upnp client error: Error: This socket has been ended by the other party
Dec 25 20:12:17 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreCommandRouter::volumioGetQueue
Dec 25 20:12:17 badradio volumio[799]: info: CoreStateMachine::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: CorePlayQueue::getQueue
Dec 25 20:12:17 badradio volumio[799]: info: touch_display: Setting screensaver timeout to 0 seconds.
Dec 25 20:12:19 badradio volumio[799]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 20:12:19 badradio volumio[799]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 20:12:19 badradio volumio[799]: info: Retrieving Cloud Streaming UI
Dec 25 20:12:20 badradio volumio[799]: info: Getting Tidal Cloud Configuration
Dec 25 20:12:20 badradio volumio[799]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 20:12:20 badradio volumio[799]: info: Getting Qobuz Cloud Configuration
Dec 25 20:12:20 badradio volumio[799]: info: Asking plugin for UI Config
Dec 25 20:12:20 badradio volumio[799]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 20:12:20 badradio volumio[799]: info: Getting Spotify Cloud Configuration
Dec 25 20:12:20 badradio volumio[799]: info: Asking plugin for UI Config
Dec 25 20:12:20 badradio volumio[799]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 20:12:20 badradio volumio[799]: info: Saving Spotify Acccount
Dec 25 20:12:20 badradio volumio[799]: info: Got Tidal Cloud Configuration
Dec 25 20:12:20 badradio volumio[799]: info: Got it
Dec 25 20:12:20 badradio volumio[799]: info: Got it
Dec 25 20:12:20 badradio volumio[799]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Dec 25 20:12:20 badradio volumio[799]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 20:12:21 badradio volumio[799]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Dec 25 20:12:22 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 25 20:12:22 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 25 20:12:22 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 25 20:12:22 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 25 20:12:22 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 25 20:12:22 badradio volumio[799]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 25 20:12:22 badradio volumio[799]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 25 20:12:25 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 20:12:25 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Dec 25 20:12:29 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 20:12:31 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Dec 25 20:12:32 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Dec 25 20:12:32 badradio volumio[799]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 20:12:38 badradio volumio[799]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 25 20:12:38 badradio volumio[799]: Error: dns service error: unknown
Dec 25 20:12:38 badradio volumio[799]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30)
Dec 25 20:12:38 badradio volumio[799]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Dec 25 20:12:38 badradio volumio[799]: errorCode: -65537
Dec 25 20:12:38 badradio volumio[799]: }
Dec 25 20:12:38 badradio volumio[799]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 25 20:12:49 badradio sudo[4259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-25 20:11
Dec 25 20:12:49 badradio sudo[4259]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"