-- Logs begin at Mon 2026-05-25 18:45:44 EEST, end at Mon 2026-05-25 18:54:33 EEST. -- May 25 18:53:00 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:00 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 25 18:53:00 volumio volumio[3141]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 25 18:53:00 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 25 18:53:00 volumio volumio[3141]: info: Received Get System Version May 25 18:53:00 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 18:53:00 volumio volumio[3141]: info: Received Get System Info May 25 18:53:00 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 18:53:00 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 18:53:00 volumio volumio[3141]: info: Discovery: Getting this device information May 25 18:53:00 volumio volumio[3141]: info: CoreCommandRouter::volumioGetState May 25 18:53:00 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 18:53:03 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 25 18:53:03 volumio volumio[3141]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101217 May 25 18:53:03 volumio volumio[3141]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101217 May 25 18:53:03 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:06 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 25 18:53:06 volumio volumio[3141]: info: TuneIn handleBrowseUri: tunein/browse/?id=r100303 May 25 18:53:06 volumio volumio[3141]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r100303 May 25 18:53:07 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:13 volumio volumio[3141]: info: May 25 18:53:13 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:53:13 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:53:13 volumio volumio[3141]: info: May 25 18:53:13 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:13 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:13 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:13 volumio volumio[3141]: info: May 25 18:53:13 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:53:13 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:53:13 volumio volumio[3141]: info: May 25 18:53:13 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:13 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:13 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:13 volumio volumio[3141]: info: ------------------------------ 2ms May 25 18:53:13 volumio volumio[3141]: info: sendMpdCommand status took 1 milliseconds May 25 18:53:13 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:13 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:13 volumio volumio[3141]: info: ------------------------------ 1ms May 25 18:53:13 volumio volumio[3141]: info: sendMpdCommand status took 1 milliseconds May 25 18:53:13 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 0 milliseconds May 25 18:53:13 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:13 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:13 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:13 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:13 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:13 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:13 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37231,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"GABRY PONTE-Exotica","artist":"Saules radijas","album":null,"uri":"http://saule-aac.vinlita.lt:8008/stream.mp3","trackType":"mp3"} May 25 18:53:13 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:13 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:53:13 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:53:13 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:53:13 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:13 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:53:13 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:13 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:13 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:13 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:13.653+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=35655 volume=46 May 25 18:53:13 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:13.653+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://saule-aac.vinlita.lt:8008/stream.mp3 title="GABRY PONTE-Exotica" May 25 18:53:13 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:13.654+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=35655 volume=46 May 25 18:53:13 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:13.654+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://saule-aac.vinlita.lt:8008/stream.mp3 title="GABRY PONTE-Exotica" May 25 18:53:13 volumio volumio[3141]: info: ------------------------------ 15ms May 25 18:53:13 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 13 milliseconds May 25 18:53:13 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:13 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:13 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:13 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:13 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37231,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"GABRY PONTE-Exotica","artist":"Saules radijas","album":null,"uri":"http://saule-aac.vinlita.lt:8008/stream.mp3","trackType":"mp3"} May 25 18:53:13 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:13 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:53:13 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:53:13 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:53:13 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:13 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:13 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:13 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:13 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:13.667+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=35655 volume=46 May 25 18:53:13 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:13.667+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://saule-aac.vinlita.lt:8008/stream.mp3 title="GABRY PONTE-Exotica" May 25 18:53:13 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:13.668+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=35655 volume=46 May 25 18:53:13 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:13.668+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://saule-aac.vinlita.lt:8008/stream.mp3 title="GABRY PONTE-Exotica" May 25 18:53:13 volumio volumio[3141]: info: ------------------------------ 29ms May 25 18:53:13 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:13 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:13 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:13 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:13 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:13 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:13 volumio sudo[4133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:13 volumio sudo[4133]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:13 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:13 volumio sudo[4136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:13 volumio sudo[4136]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:13 volumio sudo[4133]: pam_unix(sudo:session): session closed for user root May 25 18:53:13 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:13 volumio sudo[4136]: pam_unix(sudo:session): session closed for user root May 25 18:53:13 volumio sudo[4139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:13 volumio sudo[4139]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:13 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:13 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:13 volumio sudo[4142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:13 volumio sudo[4139]: pam_unix(sudo:session): session closed for user root May 25 18:53:13 volumio sudo[4142]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:13 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:13 volumio sudo[4142]: pam_unix(sudo:session): session closed for user root May 25 18:53:13 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:15 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 25 18:53:15 volumio volumio[3141]: info: TuneIn handleBrowseUri: tunein/browse/?id=r100552 May 25 18:53:15 volumio volumio[3141]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r100552 May 25 18:53:15 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:15 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:18 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:18 volumio volumio[3141]: info: CoreCommandRouter::volumioReplaceandPlayItems May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::ClearQueue May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::stop May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::stPlaybackTimer May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::updateTrackBlock May 25 18:53:18 volumio volumio[3141]: info: CorePlayQueue::getTrackBlock May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:18 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:18 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:53:18 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::serviceStop May 25 18:53:18 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:18 volumio volumio[3141]: info: CoreCommandRouter::serviceStop May 25 18:53:18 volumio volumio[3141]: info: [1779724398949] ControllerWebradio::stop May 25 18:53:18 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand stop May 25 18:53:18 volumio volumio[3141]: info: CorePlayQueue::clearPlayQueue May 25 18:53:18 volumio volumio[3141]: info: CorePlayQueue::saveQueue May 25 18:53:18 volumio volumio[3141]: info: CoreCommandRouter::volumioPushQueue May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::addQueueItems May 25 18:53:18 volumio volumio[3141]: info: CorePlayQueue::addQueueItems May 25 18:53:18 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:18 volumio volumio[3141]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s254560 May 25 18:53:18 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 25 18:53:18 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:18.953+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_STOPPED positionMs=0 volume=46 May 25 18:53:18 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:18.953+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://saule-aac.vinlita.lt:8008/stream.mp3 title="Saules Radijas" May 25 18:53:18 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: play May 25 18:53:18 volumio volumio[3141]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 25 18:53:18 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:53:18 volumio sudo[4160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:53:18 volumio sudo[4160]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:18 volumio systemd[1]: Stopping peppymeterbasic Daemon... May 25 18:53:18 volumio systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM May 25 18:53:18 volumio volumio[3141]: info: May 25 18:53:18 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:18 volumio volumio[3141]: info: sendMpdCommand stop took 43 milliseconds May 25 18:53:18 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:18 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:18 volumio volumio[3141]: info: May 25 18:53:18 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:18 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:18 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:18 volumio volumio[3141]: info: sendMpdCommand status took 1 milliseconds May 25 18:53:18 volumio volumio[3141]: info: sendMpdCommand status took 1 milliseconds May 25 18:53:18 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:18 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:18 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:18 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:18 volumio volumio[3141]: info: touch_display: Setting screensaver timeout to 360 seconds. May 25 18:53:18 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 1 milliseconds May 25 18:53:18 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 1 milliseconds May 25 18:53:18 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:18 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:18 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:18 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:18 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:18 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:53:18 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:18 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:18 volumio volumio[3141]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"GABRY PONTE-Exotica","artist":"Saules radijas","album":null,"uri":"http://saule-aac.vinlita.lt:8008/stream.mp3","trackType":"mp3"} May 25 18:53:18 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::syncState stateService stop May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus stop May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:18 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:18 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:18 volumio volumio[3141]: info: No code May 25 18:53:18 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:19 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:19 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:19 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:19 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:19 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:19 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:19 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:19 volumio volumio[3141]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"GABRY PONTE-Exotica","artist":"Saules radijas","album":null,"uri":"http://saule-aac.vinlita.lt:8008/stream.mp3","trackType":"mp3"} May 25 18:53:19 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::syncState stateService stop May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus stop May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:19 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:19 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:19 volumio volumio[3141]: info: No code May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:19 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:19 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.010+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_STOPPED positionMs=0 volume=46 May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.010+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id= title= May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.010+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_STOPPED positionMs=0 volume=46 May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.010+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id= title= May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.011+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_STOPPED positionMs=0 volume=46 May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.011+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id= title= May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.011+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_STOPPED positionMs=0 volume=46 May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.011+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id= title= May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.011+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_STOPPED positionMs=0 volume=46 May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.011+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id= title= May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.012+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_STOPPED positionMs=0 volume=46 May 25 18:53:19 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:19.012+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id= title= May 25 18:53:19 volumio volumio[3141]: info: ------------------------------ 35ms May 25 18:53:19 volumio volumio[3141]: info: ------------------------------ 34ms May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: play May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: play May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: play May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: play May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: play May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: play May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 25 18:53:19 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:53:19 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:53:19 volumio sudo[4165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:53:19 volumio sudo[4165]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:19 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:53:19 volumio sudo[4168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:53:19 volumio systemd[1]: peppymeterbasic.service: Succeeded. May 25 18:53:19 volumio systemd[1]: Stopped peppymeterbasic Daemon. May 25 18:53:19 volumio sudo[4168]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:19 volumio sudo[4160]: pam_unix(sudo:session): session closed for user root May 25 18:53:19 volumio sudo[4165]: pam_unix(sudo:session): session closed for user root May 25 18:53:19 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:53:19 volumio sudo[4168]: pam_unix(sudo:session): session closed for user root May 25 18:53:19 volumio sudo[4171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:53:19 volumio sudo[4171]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:19 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:53:19 volumio sudo[4171]: pam_unix(sudo:session): session closed for user root May 25 18:53:19 volumio sudo[4174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:53:19 volumio sudo[4174]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:19 volumio sudo[4174]: pam_unix(sudo:session): session closed for user root May 25 18:53:19 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:53:19 volumio sudo[4177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:53:19 volumio sudo[4177]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:19 volumio sudo[4180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:53:19 volumio sudo[4180]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:19 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:53:19 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:53:19 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:53:19 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:53:19 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:53:19 volumio sudo[4177]: pam_unix(sudo:session): session closed for user root May 25 18:53:19 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:53:19 volumio sudo[4180]: pam_unix(sudo:session): session closed for user root May 25 18:53:19 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:53:19 volumio volumio[3141]: info: CoreCommandRouter::volumioPushQueue May 25 18:53:19 volumio volumio[3141]: info: CorePlayQueue::saveQueue May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::updateTrackBlock May 25 18:53:19 volumio volumio[3141]: info: CorePlayQueue::getTrackBlock May 25 18:53:19 volumio volumio[3141]: info: CoreCommandRouter::volumioPlay May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::play index 0 May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::stop May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::play index undefined May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:53:19 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:19 volumio volumio[3141]: info: CoreStateMachine::startPlaybackTimer May 25 18:53:19 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:19 volumio volumio[3141]: info: [1779724399556] ControllerWebradio::clearAddPlayTrack May 25 18:53:19 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand stop May 25 18:53:19 volumio volumio[3141]: info: sendMpdCommand stop took 1 milliseconds May 25 18:53:19 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand clear May 25 18:53:19 volumio volumio[3141]: info: May 25 18:53:19 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:53:19 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:53:19 volumio volumio[3141]: info: sendMpdCommand clear took 1 milliseconds May 25 18:53:19 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand load "http://live.humorfm.by:8000/veseloe" May 25 18:53:19 volumio volumio[3141]: info: May 25 18:53:19 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:53:19 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:53:19 volumio volumio[3141]: error: updateQueue error: null May 25 18:53:19 volumio volumio[3141]: info: ------------------------------ 1ms May 25 18:53:19 volumio volumio[3141]: info: [ASDebug] Togle GPIO: OFF May 25 18:53:20 volumio volumio[3141]: error: updateQueue error: null May 25 18:53:20 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand add "http://live.humorfm.by:8000/veseloe" May 25 18:53:20 volumio volumio[3141]: info: ------------------------------ 1388ms May 25 18:53:20 volumio volumio[3141]: info: May 25 18:53:20 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:53:20 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:53:20 volumio volumio[3141]: info: sendMpdCommand add "http://live.humorfm.by:8000/veseloe" took 0 milliseconds May 25 18:53:20 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService mpd May 25 18:53:20 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand play May 25 18:53:20 volumio volumio[3141]: info: May 25 18:53:20 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:53:20 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:53:20 volumio volumio[3141]: info: ------------------------------ 1ms May 25 18:53:20 volumio volumio[3141]: info: sendMpdCommand play took 1 milliseconds May 25 18:53:20 volumio volumio[3141]: info: ------------------------------ 0ms May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:21 volumio volumio[3141]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 25 18:53:21 volumio volumio[3141]: info: FusionDsp - ---- read samplerate from file: 44100 May 25 18:53:21 volumio volumio[3141]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 25 18:53:21 volumio volumio[3141]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 25 18:53:21 volumio volumio[3141]: info: FusionDsp - ---- read samplerate from file: 44100 May 25 18:53:21 volumio volumio[3141]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand status took 10 milliseconds May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand status took 10 milliseconds May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand status took 2 milliseconds May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 1 milliseconds May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand status took 1 milliseconds May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"veseloe","artist":null,"album":null,"uri":"http://live.humorfm.by:8000/veseloe","trackType":""} May 25 18:53:21 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus stop May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"veseloe","artist":null,"album":null,"uri":"http://live.humorfm.by:8000/veseloe","trackType":""} May 25 18:53:21 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:53:21 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 19ms May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.725+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=0 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.725+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.724+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=0 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.725+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 27ms May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:53:21 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 16 milliseconds May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 16 milliseconds May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"veseloe","artist":null,"album":null,"uri":"http://live.humorfm.by:8000/veseloe","trackType":""} May 25 18:53:21 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:53:21 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"veseloe","artist":null,"album":null,"uri":"http://live.humorfm.by:8000/veseloe","trackType":""} May 25 18:53:21 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:53:21 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.752+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=0 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.752+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.752+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=0 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.752+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.753+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=0 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.754+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.754+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=0 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.754+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 50ms May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 50ms May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: stop May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] Togle GPIO: ON May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:21 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:21 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:21 volumio sudo[4197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:21 volumio sudo[4197]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:21 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:21 volumio sudo[4200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:21 volumio sudo[4200]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:21 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:21 volumio sudo[4204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:21 volumio systemd[1]: Started peppymeterbasic Daemon. May 25 18:53:21 volumio sudo[4204]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:21 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:21 volumio sudo[4207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:21 volumio sudo[4207]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:21 volumio sudo[4197]: pam_unix(sudo:session): session closed for user root May 25 18:53:21 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:21 volumio sudo[4211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:21 volumio sudo[4211]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:21 volumio sudo[4200]: pam_unix(sudo:session): session closed for user root May 25 18:53:21 volumio sudo[4207]: pam_unix(sudo:session): session closed for user root May 25 18:53:21 volumio sudo[4204]: pam_unix(sudo:session): session closed for user root May 25 18:53:21 volumio sudo[4214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:21 volumio sudo[4211]: pam_unix(sudo:session): session closed for user root May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:53:21 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:21 volumio sudo[4214]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:53:21 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 138ms May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand status took 139 milliseconds May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 5ms May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand status took 3 milliseconds May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:21 volumio volumio[3141]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:53:21 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:53:21 volumio volumio[3141]: info: May 25 18:53:21 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:21 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:21 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:21 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:21 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:21 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 10ms May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand status took 8 milliseconds May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 8 milliseconds May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 8 milliseconds May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 7ms May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand status took 7 milliseconds May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:21 volumio sudo[4214]: pam_unix(sudo:session): session closed for user root May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1418,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"veseloe","artist":"YUMOR FM BELARUS","album":null,"uri":"http://live.humorfm.by:8000/veseloe","trackType":""} May 25 18:53:21 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:53:21 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1848,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"veseloe","artist":"YUMOR FM BELARUS","album":null,"uri":"http://live.humorfm.by:8000/veseloe","trackType":""} May 25 18:53:21 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:53:21 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.903+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=309 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.903+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.905+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=309 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.905+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.905+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=309 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.905+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.905+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=309 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.905+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 183ms May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 50ms May 25 18:53:21 volumio volumio[3141]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 57 milliseconds May 25 18:53:21 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 56 milliseconds May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:21 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1848,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"veseloe","artist":"YUMOR FM BELARUS","album":null,"uri":"http://live.humorfm.by:8000/veseloe","trackType":""} May 25 18:53:21 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:53:21 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1848,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"veseloe","artist":"YUMOR FM BELARUS","album":null,"uri":"http://live.humorfm.by:8000/veseloe","trackType":""} May 25 18:53:21 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:53:21 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:21 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.961+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=309 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.961+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.961+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=309 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.961+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.962+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=309 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.962+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.963+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" state=STATUS_PLAYING positionMs=309 volume=46 May 25 18:53:21 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:21.963+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.239:34352 @ 0x36071a0" id=http://live.humorfm.by:8000/veseloe title="Humor FM" May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 102ms May 25 18:53:21 volumio volumio[3141]: info: ------------------------------ 99ms May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:21 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:53:21 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:21 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:21 volumio sudo[4219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:21 volumio sudo[4219]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:21 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:22 volumio sudo[4219]: pam_unix(sudo:session): session closed for user root May 25 18:53:22 volumio sudo[4222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:22 volumio sudo[4222]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:22 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:22 volumio sudo[4222]: pam_unix(sudo:session): session closed for user root May 25 18:53:22 volumio sudo[4225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:22 volumio sudo[4225]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:22 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:22 volumio sudo[4228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:22 volumio sudo[4228]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:22 volumio sudo[4225]: pam_unix(sudo:session): session closed for user root May 25 18:53:22 volumio sudo[4228]: pam_unix(sudo:session): session closed for user root May 25 18:53:22 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:22 volumio sudo[4231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:22 volumio sudo[4231]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:22 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:22 volumio sudo[4231]: pam_unix(sudo:session): session closed for user root May 25 18:53:22 volumio sudo[4234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:22 volumio sudo[4234]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:22 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:53:22 volumio sudo[4237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:22 volumio sudo[4237]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:22 volumio sudo[4234]: pam_unix(sudo:session): session closed for user root May 25 18:53:22 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:22 volumio sudo[4240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:53:22 volumio sudo[4240]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:22 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:22 volumio volumio[3141]: info: touch_display: Setting screensaver timeout to 0 seconds. May 25 18:53:22 volumio sudo[4237]: pam_unix(sudo:session): session closed for user root May 25 18:53:22 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:22 volumio sudo[4240]: pam_unix(sudo:session): session closed for user root May 25 18:53:22 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:53:22 volumio volumio[4201]: libpng warning: iCCP: known incorrect sRGB profile May 25 18:53:22 volumio volumio[4201]: libpng warning: iCCP: known incorrect sRGB profile May 25 18:53:22 volumio volumio[4201]: libpng warning: iCCP: known incorrect sRGB profile May 25 18:53:38 volumio volumio[3141]: verbose: New Socket.io Connection to 192.168.0.2 from 192.168.0.239 UA: Mozilla/5.0 (Linux; Android 13; BV8900 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/148.0.7778.120 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::volumioGetVisibleSources May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::volumioGetState May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 18:53:38 volumio volumio[3141]: info: Received Get System Info May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 25 18:53:38 volumio volumio[3141]: info: Discovery: Getting this device information May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::volumioGetState May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::volumioGetState May 25 18:53:38 volumio volumio[3141]: info: Listing playlists May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 18:53:38 volumio volumio[3141]: info: FusionDsp - Bass-FusionDsp May 25 18:53:38 volumio volumio[3141]: info: FusionDsp - Bass-FusionDsp May 25 18:53:38 volumio volumio[3141]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 18:53:38 volumio volumio[3141]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 25 18:53:38 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 25 18:53:43 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:43 volumio volumio[3141]: info: Preloading song: webnineties/0 May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:5OtRUowagv3aSAcjekQmDm May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:77LA2Zd0H9c1C0NutqumLH May 25 18:53:43 volumio volumio[3141]: info: Preloading song: youtube2/video@videoId=vCihOePh8TQ May 25 18:53:43 volumio volumio[3141]: info: Preloading song: youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=GlPlfCy1urI May 25 18:53:43 volumio volumio[3141]: info: Preloading song: youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=ZHwVBirqD2s May 25 18:53:43 volumio volumio[3141]: info: Preloading song: youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=ZHwVBirqD2s May 25 18:53:43 volumio volumio[3141]: info: Preloading song: youtube2/videos@search=Savage%20-%20Only%20You%20%26%20Don't%20Cry%20Tonight@title=Videos%20matching%20'Savage%20-%20Only%20You%20%26%20Don't%20Cry%20Tonight'/video@videoId=pvi9bhgRE-8 May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:0hcY1gJD8yQWdgi2oGVZCG May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:2hqhk4aJvGD83if17a4kH3 May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:2uFaJJtFpPDc5Pa95XzTvg May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:6RmV54gl0nByycqhTajiiZ May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:5fvsfW5tDcwaQlocNzlTKr May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:3MrRksHupTVEQ7YbA0FsZK May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:3MrRksHupTVEQ7YbA0FsZK May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:6pPWRBubXOBAHnjl5ZIujB May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:4eHbdreAnSOrDDsFfc4Fpm May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:1sgGy5HcUAdYoWGj3RXmYb May 25 18:53:43 volumio volumio[3141]: info: Preloading song: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Flowers%20(Demo%20-%20Official%20Lyric%20Video)%22%2C%22artist%22%3A%22Miley%20Cyrus%22%2C%22album%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FFLo4r8deDeI%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNUGEOADIAQqCwjVARCqCBh4INgESFo%26rs%3DAMzJL3kvSgZSd-ZT7DA4OcnrP0fas4ugJA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22FLo4r8deDeI%22%2C%22playlistId%22%3A%22RDCLAK5uy_mdwsZFtQhJyGQPuQA612VoRPXp-OJfzx8%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%2256B44F6D10557CC6%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_OMV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_mdwsZFtQhJyGQPuQA612VoRPXp-OJfzx8%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22amZnfpyHT94%22%7D%7D%7D%7D May 25 18:53:43 volumio volumio[3141]: info: Preloading song: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22artist%22%3A%22%D0%95%D0%BB%D0%B5%D0%BD%D0%B0%20%D0%92%D0%BE%D1%80%D0%BE%D0%B1%D0%B5%D0%B9%22%2C%22album%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLazpt1kKRME1cmiGrydWGUhoXyIbBYCAF2ZLQy143ACL0DZyjTYdPlUSdAtkCbD4vAaM9v4YqF_g78Mt%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D May 25 18:53:43 volumio volumio[3141]: info: Preloading song: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22artist%22%3A%22%D0%95%D0%BB%D0%B5%D0%BD%D0%B0%20%D0%92%D0%BE%D1%80%D0%BE%D0%B1%D0%B5%D0%B9%22%2C%22album%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLazpt1kKRME1cmiGrydWGUhoXyIbBYCAF2ZLQy143ACL0DZyjTYdPlUSdAtkCbD4vAaM9v4YqF_g78Mt%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:3IPnBzGRMg6BfViFxxa0Gq May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:6OuRbvP4PgbuzBIapVzmFJ May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:1ojbRSyn6rjrS70cDToHRx May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:6QLspHLCLftSGPa6vNzKuo May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:3BQHpFgAp4l80e1XslIjNI May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:1aYiTN5P4hPextcbTbL1D0 May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:2GMxS3x59raBvdX9SFNmtC May 25 18:53:43 volumio volumio[3141]: info: Preloading song: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%9A%D0%BE%D0%BD%D1%8C%22%2C%22artist%22%3A%22%D0%9B%D1%8E%D0%B1%D1%8D%22%2C%22album%22%3A%22%D0%97%D0%BE%D0%BD%D0%B0%20%D0%9B%D0%AE%D0%91%D0%AD%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FDQr544FmVw8YmAXmpI3bNlcSa40htqF2GoZxEncrHAq28DmfIJ8G7vs1DrDfGDtdJHyD0YLLmCb-Jy1fEQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2250ysevZeiLE%22%2C%22playlistId%22%3A%22RDAMVM50ysevZeiLE%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2250ysevZeiLE%22%2C%22playlistId%22%3A%22RDAMVM50ysevZeiLE%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:0k49LQ3oOORQ6SDTn2Oewb May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:3MVm36ouM56jbP5rORxbVy May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:1JKVLJVwph77LvMiZvr1qT May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:2HZYd77sYiDXOdKdcmuLGM May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:38grlitW19BsvUcEE5pz9Z May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:4lqrf70Sr6lqzzZeoDxd2i May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:1rSKI53jRPRneZETM1655h May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:5Z78VaWfMqkvvAB1aaRCWf May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:6EOpPeCBiBYF0yITU0VQwT May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:6ergILbKndfxQGVmENezkL May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:2Z1sgBIFEXCQ5w2biVAoG5 May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:5fvsfW5tDcwaQlocNzlTKr May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:7CRvHw452BzxGdoIitVFKX May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:1TkcIqQWpezpbusyBfmnBT May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:4c8Efcin4xbzkOyfHqLZUM May 25 18:53:43 volumio volumio[3141]: info: Preloading song: spotify:track:0hsiU01wuRJGFsouJM1r9l May 25 18:53:43 volumio volumio[3141]: info: Exploding uri webnineties/0 in service 80s80s May 25 18:53:43 volumio volumio[3141]: info: Exploding uri spotify:track:5OtRUowagv3aSAcjekQmDm in service spop May 25 18:53:43 volumio volumio[3141]: info: Exploding uri spotify:track:77LA2Zd0H9c1C0NutqumLH in service spop May 25 18:53:43 volumio volumio[3141]: info: Exploding uri youtube2/video@videoId=vCihOePh8TQ in service youtube2 May 25 18:53:43 volumio volumio[3141]: info: Exploding uri youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=GlPlfCy1urI in service youtube2 May 25 18:53:43 volumio volumio[3141]: info: Exploding uri youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=ZHwVBirqD2s in service youtube2 May 25 18:53:43 volumio volumio[3141]: info: Exploding uri youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=ZHwVBirqD2s in service youtube2 May 25 18:53:43 volumio volumio[3141]: info: Exploding uri youtube2/videos@search=Savage%20-%20Only%20You%20%26%20Don't%20Cry%20Tonight@title=Videos%20matching%20'Savage%20-%20Only%20You%20%26%20Don't%20Cry%20Tonight'/video@videoId=pvi9bhgRE-8 in service youtube2 May 25 18:53:43 volumio volumio[3141]: info: Exploding uri spotify:track:0hcY1gJD8yQWdgi2oGVZCG in service spop May 25 18:53:43 volumio volumio[3141]: info: Exploding uri spotify:track:2hqhk4aJvGD83if17a4kH3 in service spop May 25 18:53:43 volumio volumio[3141]: info: Exploding uri spotify:track:2uFaJJtFpPDc5Pa95XzTvg in service spop May 25 18:53:43 volumio volumio[3141]: info: Exploding uri spotify:track:6RmV54gl0nByycqhTajiiZ in service spop May 25 18:53:43 volumio volumio[3141]: info: Exploding uri spotify:track:5fvsfW5tDcwaQlocNzlTKr in service spop May 25 18:53:43 volumio volumio[3141]: info: Exploding uri spotify:track:3MrRksHupTVEQ7YbA0FsZK in service spop May 25 18:53:43 volumio volumio[3141]: info: Exploding uri spotify:track:3MrRksHupTVEQ7YbA0FsZK in service spop May 25 18:53:43 volumio volumio[3141]: info: Exploding uri spotify:track:3MrRksHupTVEQ7YbA0FsZK in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:6pPWRBubXOBAHnjl5ZIujB in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:4eHbdreAnSOrDDsFfc4Fpm in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:1sgGy5HcUAdYoWGj3RXmYb in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Flowers%20(Demo%20-%20Official%20Lyric%20Video)%22%2C%22artist%22%3A%22Miley%20Cyrus%22%2C%22album%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FFLo4r8deDeI%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNUGEOADIAQqCwjVARCqCBh4INgESFo%26rs%3DAMzJL3kvSgZSd-ZT7DA4OcnrP0fas4ugJA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22FLo4r8deDeI%22%2C%22playlistId%22%3A%22RDCLAK5uy_mdwsZFtQhJyGQPuQA612VoRPXp-OJfzx8%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%2256B44F6D10557CC6%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_OMV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_mdwsZFtQhJyGQPuQA612VoRPXp-OJfzx8%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22amZnfpyHT94%22%7D%7D%7D%7D in service ytmusic May 25 18:53:44 volumio volumio[3141]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22artist%22%3A%22%D0%95%D0%BB%D0%B5%D0%BD%D0%B0%20%D0%92%D0%BE%D1%80%D0%BE%D0%B1%D0%B5%D0%B9%22%2C%22album%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLazpt1kKRME1cmiGrydWGUhoXyIbBYCAF2ZLQy143ACL0DZyjTYdPlUSdAtkCbD4vAaM9v4YqF_g78Mt%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic May 25 18:53:44 volumio volumio[3141]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22artist%22%3A%22%D0%95%D0%BB%D0%B5%D0%BD%D0%B0%20%D0%92%D0%BE%D1%80%D0%BE%D0%B1%D0%B5%D0%B9%22%2C%22album%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLazpt1kKRME1cmiGrydWGUhoXyIbBYCAF2ZLQy143ACL0DZyjTYdPlUSdAtkCbD4vAaM9v4YqF_g78Mt%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:3IPnBzGRMg6BfViFxxa0Gq in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:6OuRbvP4PgbuzBIapVzmFJ in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:1ojbRSyn6rjrS70cDToHRx in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:6QLspHLCLftSGPa6vNzKuo in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:3BQHpFgAp4l80e1XslIjNI in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:1aYiTN5P4hPextcbTbL1D0 in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:2GMxS3x59raBvdX9SFNmtC in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%9A%D0%BE%D0%BD%D1%8C%22%2C%22artist%22%3A%22%D0%9B%D1%8E%D0%B1%D1%8D%22%2C%22album%22%3A%22%D0%97%D0%BE%D0%BD%D0%B0%20%D0%9B%D0%AE%D0%91%D0%AD%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FDQr544FmVw8YmAXmpI3bNlcSa40htqF2GoZxEncrHAq28DmfIJ8G7vs1DrDfGDtdJHyD0YLLmCb-Jy1fEQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2250ysevZeiLE%22%2C%22playlistId%22%3A%22RDAMVM50ysevZeiLE%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2250ysevZeiLE%22%2C%22playlistId%22%3A%22RDAMVM50ysevZeiLE%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:0k49LQ3oOORQ6SDTn2Oewb in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:3MVm36ouM56jbP5rORxbVy in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:1JKVLJVwph77LvMiZvr1qT in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:2HZYd77sYiDXOdKdcmuLGM in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:38grlitW19BsvUcEE5pz9Z in service spop May 25 18:53:44 volumio volumio[3141]: info: Exploding uri spotify:track:4lqrf70Sr6lqzzZeoDxd2i in service spop May 25 18:53:45 volumio volumio[3141]: info: Exploding uri spotify:track:1rSKI53jRPRneZETM1655h in service spop May 25 18:53:45 volumio volumio[3141]: info: Exploding uri spotify:track:5Z78VaWfMqkvvAB1aaRCWf in service spop May 25 18:53:45 volumio volumio[3141]: info: Exploding uri spotify:track:6EOpPeCBiBYF0yITU0VQwT in service spop May 25 18:53:45 volumio volumio[3141]: info: Exploding uri spotify:track:6ergILbKndfxQGVmENezkL in service spop May 25 18:53:45 volumio volumio[3141]: info: Exploding uri spotify:track:2Z1sgBIFEXCQ5w2biVAoG5 in service spop May 25 18:53:45 volumio volumio[3141]: info: Exploding uri spotify:track:5fvsfW5tDcwaQlocNzlTKr in service spop May 25 18:53:45 volumio volumio[3141]: info: Exploding uri spotify:track:7CRvHw452BzxGdoIitVFKX in service spop May 25 18:53:45 volumio volumio[3141]: info: Exploding uri spotify:track:1TkcIqQWpezpbusyBfmnBT in service spop May 25 18:53:45 volumio volumio[3141]: info: Exploding uri spotify:track:4c8Efcin4xbzkOyfHqLZUM in service spop May 25 18:53:45 volumio volumio[3141]: info: Exploding uri spotify:track:0hsiU01wuRJGFsouJM1r9l in service spop May 25 18:53:46 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:46.977+03:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.0.239:33918 error="websocket: close 1006 (abnormal closure): unexpected EOF" May 25 18:53:46 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:46.977+03:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.0.239:33918 May 25 18:53:46 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:46.977+03:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.0.239:33918 May 25 18:53:46 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:46.978+03:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.0.239:34352 error="websocket: close 1006 (abnormal closure): unexpected EOF" May 25 18:53:46 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:46.978+03:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.0.239:34352 May 25 18:53:46 volumio volumio5-onboarding[2279]: time=2026-05-25T18:53:46.979+03:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.0.239:34352 May 25 18:53:48 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::volumioReplaceandPlayItems May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::ClearQueue May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::stop May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::stPlaybackTimer May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::updateTrackBlock May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrackBlock May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::serviceStop May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::serviceStop May 25 18:53:48 volumio volumio[3141]: info: [1779724428459] ControllerWebradio::stop May 25 18:53:48 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand stop May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::clearPlayQueue May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::saveQueue May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::volumioPushQueue May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::addQueueItems May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::addQueueItems May 25 18:53:48 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: webnineties/0 May 25 18:53:48 volumio volumio[3141]: info: Exploding uri webnineties/0 in service 80s80s May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:5OtRUowagv3aSAcjekQmDm May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:5OtRUowagv3aSAcjekQmDm in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:77LA2Zd0H9c1C0NutqumLH May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:77LA2Zd0H9c1C0NutqumLH in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: youtube2/video@videoId=vCihOePh8TQ May 25 18:53:48 volumio volumio[3141]: info: Exploding uri youtube2/video@videoId=vCihOePh8TQ in service youtube2 May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=GlPlfCy1urI May 25 18:53:48 volumio volumio[3141]: info: Exploding uri youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=GlPlfCy1urI in service youtube2 May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=ZHwVBirqD2s May 25 18:53:48 volumio volumio[3141]: info: Exploding uri youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=ZHwVBirqD2s in service youtube2 May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=ZHwVBirqD2s May 25 18:53:48 volumio volumio[3141]: info: Exploding uri youtube2/videos@search=elton@title=Videos%20matching%20'elton'/video@videoId=ZHwVBirqD2s in service youtube2 May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: youtube2/videos@search=Savage%20-%20Only%20You%20%26%20Don't%20Cry%20Tonight@title=Videos%20matching%20'Savage%20-%20Only%20You%20%26%20Don't%20Cry%20Tonight'/video@videoId=pvi9bhgRE-8 May 25 18:53:48 volumio volumio[3141]: info: Exploding uri youtube2/videos@search=Savage%20-%20Only%20You%20%26%20Don't%20Cry%20Tonight@title=Videos%20matching%20'Savage%20-%20Only%20You%20%26%20Don't%20Cry%20Tonight'/video@videoId=pvi9bhgRE-8 in service youtube2 May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:0hcY1gJD8yQWdgi2oGVZCG May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:0hcY1gJD8yQWdgi2oGVZCG in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:2hqhk4aJvGD83if17a4kH3 May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:2hqhk4aJvGD83if17a4kH3 in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:2uFaJJtFpPDc5Pa95XzTvg May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:2uFaJJtFpPDc5Pa95XzTvg in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:6RmV54gl0nByycqhTajiiZ May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:6RmV54gl0nByycqhTajiiZ in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:5fvsfW5tDcwaQlocNzlTKr May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:5fvsfW5tDcwaQlocNzlTKr in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:3MrRksHupTVEQ7YbA0FsZK May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:3MrRksHupTVEQ7YbA0FsZK in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:3MrRksHupTVEQ7YbA0FsZK May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:3MrRksHupTVEQ7YbA0FsZK in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:3MrRksHupTVEQ7YbA0FsZK May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:3MrRksHupTVEQ7YbA0FsZK in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:6pPWRBubXOBAHnjl5ZIujB May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:6pPWRBubXOBAHnjl5ZIujB in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:4eHbdreAnSOrDDsFfc4Fpm May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:4eHbdreAnSOrDDsFfc4Fpm in service spop May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::volumioPushQueue May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::saveQueue May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::updateTrackBlock May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrackBlock May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::volumioPlay May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::play index 17 May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::addQueueItems May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::addQueueItems May 25 18:53:48 volumio volumio[3141]: info: Preload queue cleared May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:1sgGy5HcUAdYoWGj3RXmYb May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:1sgGy5HcUAdYoWGj3RXmYb in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Flowers%20(Demo%20-%20Official%20Lyric%20Video)%22%2C%22artist%22%3A%22Miley%20Cyrus%22%2C%22album%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FFLo4r8deDeI%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNUGEOADIAQqCwjVARCqCBh4INgESFo%26rs%3DAMzJL3kvSgZSd-ZT7DA4OcnrP0fas4ugJA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22FLo4r8deDeI%22%2C%22playlistId%22%3A%22RDCLAK5uy_mdwsZFtQhJyGQPuQA612VoRPXp-OJfzx8%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%2256B44F6D10557CC6%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_OMV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_mdwsZFtQhJyGQPuQA612VoRPXp-OJfzx8%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22amZnfpyHT94%22%7D%7D%7D%7D May 25 18:53:48 volumio volumio[3141]: info: Exploding uri ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Flowers%20(Demo%20-%20Official%20Lyric%20Video)%22%2C%22artist%22%3A%22Miley%20Cyrus%22%2C%22album%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FFLo4r8deDeI%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNUGEOADIAQqCwjVARCqCBh4INgESFo%26rs%3DAMzJL3kvSgZSd-ZT7DA4OcnrP0fas4ugJA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22FLo4r8deDeI%22%2C%22playlistId%22%3A%22RDCLAK5uy_mdwsZFtQhJyGQPuQA612VoRPXp-OJfzx8%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%2256B44F6D10557CC6%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_OMV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_mdwsZFtQhJyGQPuQA612VoRPXp-OJfzx8%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22amZnfpyHT94%22%7D%7D%7D%7D in service ytmusic May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22artist%22%3A%22%D0%95%D0%BB%D0%B5%D0%BD%D0%B0%20%D0%92%D0%BE%D1%80%D0%BE%D0%B1%D0%B5%D0%B9%22%2C%22album%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLazpt1kKRME1cmiGrydWGUhoXyIbBYCAF2ZLQy143ACL0DZyjTYdPlUSdAtkCbD4vAaM9v4YqF_g78Mt%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D May 25 18:53:48 volumio volumio[3141]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22artist%22%3A%22%D0%95%D0%BB%D0%B5%D0%BD%D0%B0%20%D0%92%D0%BE%D1%80%D0%BE%D0%B1%D0%B5%D0%B9%22%2C%22album%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLazpt1kKRME1cmiGrydWGUhoXyIbBYCAF2ZLQy143ACL0DZyjTYdPlUSdAtkCbD4vAaM9v4YqF_g78Mt%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22artist%22%3A%22%D0%95%D0%BB%D0%B5%D0%BD%D0%B0%20%D0%92%D0%BE%D1%80%D0%BE%D0%B1%D0%B5%D0%B9%22%2C%22album%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLazpt1kKRME1cmiGrydWGUhoXyIbBYCAF2ZLQy143ACL0DZyjTYdPlUSdAtkCbD4vAaM9v4YqF_g78Mt%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D May 25 18:53:48 volumio volumio[3141]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22artist%22%3A%22%D0%95%D0%BB%D0%B5%D0%BD%D0%B0%20%D0%92%D0%BE%D1%80%D0%BE%D0%B1%D0%B5%D0%B9%22%2C%22album%22%3A%22%D0%92%D1%81%D0%B5%20%D0%BF%D0%B5%D1%80%D0%B5%D0%BC%D0%B5%D0%BB%D0%B5%D1%82%D1%81%D1%8F%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLazpt1kKRME1cmiGrydWGUhoXyIbBYCAF2ZLQy143ACL0DZyjTYdPlUSdAtkCbD4vAaM9v4YqF_g78Mt%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ehtwie0Vx7Y%22%2C%22playlistId%22%3A%22RDAMVMEhtwie0Vx7Y%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:3IPnBzGRMg6BfViFxxa0Gq May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:3IPnBzGRMg6BfViFxxa0Gq in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:6OuRbvP4PgbuzBIapVzmFJ May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:6OuRbvP4PgbuzBIapVzmFJ in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:1ojbRSyn6rjrS70cDToHRx May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:1ojbRSyn6rjrS70cDToHRx in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:6QLspHLCLftSGPa6vNzKuo May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:6QLspHLCLftSGPa6vNzKuo in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:3BQHpFgAp4l80e1XslIjNI May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:3BQHpFgAp4l80e1XslIjNI in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:1aYiTN5P4hPextcbTbL1D0 May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:1aYiTN5P4hPextcbTbL1D0 in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:2GMxS3x59raBvdX9SFNmtC May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:2GMxS3x59raBvdX9SFNmtC in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%9A%D0%BE%D0%BD%D1%8C%22%2C%22artist%22%3A%22%D0%9B%D1%8E%D0%B1%D1%8D%22%2C%22album%22%3A%22%D0%97%D0%BE%D0%BD%D0%B0%20%D0%9B%D0%AE%D0%91%D0%AD%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FDQr544FmVw8YmAXmpI3bNlcSa40htqF2GoZxEncrHAq28DmfIJ8G7vs1DrDfGDtdJHyD0YLLmCb-Jy1fEQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2250ysevZeiLE%22%2C%22playlistId%22%3A%22RDAMVM50ysevZeiLE%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2250ysevZeiLE%22%2C%22playlistId%22%3A%22RDAMVM50ysevZeiLE%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D May 25 18:53:48 volumio volumio[3141]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22%D0%9A%D0%BE%D0%BD%D1%8C%22%2C%22artist%22%3A%22%D0%9B%D1%8E%D0%B1%D1%8D%22%2C%22album%22%3A%22%D0%97%D0%BE%D0%BD%D0%B0%20%D0%9B%D0%AE%D0%91%D0%AD%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FDQr544FmVw8YmAXmpI3bNlcSa40htqF2GoZxEncrHAq28DmfIJ8G7vs1DrDfGDtdJHyD0YLLmCb-Jy1fEQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2250ysevZeiLE%22%2C%22playlistId%22%3A%22RDAMVM50ysevZeiLE%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%2250ysevZeiLE%22%2C%22playlistId%22%3A%22RDAMVM50ysevZeiLE%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:0k49LQ3oOORQ6SDTn2Oewb May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:0k49LQ3oOORQ6SDTn2Oewb in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:3MVm36ouM56jbP5rORxbVy May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:3MVm36ouM56jbP5rORxbVy in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:1JKVLJVwph77LvMiZvr1qT May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:1JKVLJVwph77LvMiZvr1qT in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:2HZYd77sYiDXOdKdcmuLGM May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:2HZYd77sYiDXOdKdcmuLGM in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:38grlitW19BsvUcEE5pz9Z May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:38grlitW19BsvUcEE5pz9Z in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:4lqrf70Sr6lqzzZeoDxd2i May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:4lqrf70Sr6lqzzZeoDxd2i in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:1rSKI53jRPRneZETM1655h May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:1rSKI53jRPRneZETM1655h in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:5Z78VaWfMqkvvAB1aaRCWf May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:5Z78VaWfMqkvvAB1aaRCWf in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:6EOpPeCBiBYF0yITU0VQwT May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:6EOpPeCBiBYF0yITU0VQwT in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:6ergILbKndfxQGVmENezkL May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:6ergILbKndfxQGVmENezkL in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:2Z1sgBIFEXCQ5w2biVAoG5 May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:2Z1sgBIFEXCQ5w2biVAoG5 in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:5fvsfW5tDcwaQlocNzlTKr May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:5fvsfW5tDcwaQlocNzlTKr in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:7CRvHw452BzxGdoIitVFKX May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:7CRvHw452BzxGdoIitVFKX in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:1TkcIqQWpezpbusyBfmnBT May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:1TkcIqQWpezpbusyBfmnBT in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:4c8Efcin4xbzkOyfHqLZUM May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:4c8Efcin4xbzkOyfHqLZUM in service spop May 25 18:53:48 volumio volumio[3141]: info: Adding Item to queue: spotify:track:0hsiU01wuRJGFsouJM1r9l May 25 18:53:48 volumio volumio[3141]: info: Exploding uri spotify:track:0hsiU01wuRJGFsouJM1r9l in service spop May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::stop May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::play index undefined May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrack 17 May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::startPlaybackTimer May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrack 17 May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::volumioPushQueue May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::saveQueue May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::updateTrackBlock May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrackBlock May 25 18:53:48 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: play May 25 18:53:48 volumio volumio[3141]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 25 18:53:48 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:53:48 volumio volumio[3141]: info: May 25 18:53:48 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:48 volumio volumio[3141]: info: sendMpdCommand stop took 42 milliseconds May 25 18:53:48 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:48 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:48 volumio volumio[3141]: info: May 25 18:53:48 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:53:48 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:53:48 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:53:48 volumio volumio[3141]: info: sendMpdCommand status took 0 milliseconds May 25 18:53:48 volumio volumio[3141]: info: sendMpdCommand status took 1 milliseconds May 25 18:53:48 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:48 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:48 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:53:48 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:53:48 volumio sudo[4331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:53:48 volumio sudo[4331]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:48 volumio systemd[1]: Stopping peppymeterbasic Daemon... May 25 18:53:48 volumio systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM May 25 18:53:48 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 11 milliseconds May 25 18:53:48 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 12 milliseconds May 25 18:53:48 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:53:48 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrack 17 May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrack 17 May 25 18:53:48 volumio volumio[3141]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd May 25 18:53:48 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:53:48 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrack 17 May 25 18:53:48 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:53:48 volumio volumio[3141]: info: CorePlayQueue::getTrack 17 May 25 18:53:48 volumio volumio[3141]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd May 25 18:53:48 volumio volumio[3141]: info: ------------------------------ 25ms May 25 18:53:48 volumio volumio[3141]: info: ------------------------------ 24ms May 25 18:53:48 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: play May 25 18:53:48 volumio volumio[3141]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 25 18:53:48 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: play May 25 18:53:48 volumio volumio[3141]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 25 18:53:48 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:53:48 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:53:48 volumio sudo[4336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:53:48 volumio sudo[4336]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:48 volumio volumio[3141]: info: touch_display: Setting screensaver timeout to 360 seconds. May 25 18:53:48 volumio sudo[4339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:53:48 volumio sudo[4339]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:53:48 volumio systemd[1]: peppymeterbasic.service: Succeeded. May 25 18:53:48 volumio systemd[1]: Stopped peppymeterbasic Daemon. May 25 18:53:48 volumio sudo[4336]: pam_unix(sudo:session): session closed for user root May 25 18:53:48 volumio sudo[4331]: pam_unix(sudo:session): session closed for user root May 25 18:53:48 volumio sudo[4339]: pam_unix(sudo:session): session closed for user root May 25 18:53:48 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:53:48 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:53:48 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:53:49 volumio volumio[3141]: info: [ASDebug] Togle GPIO: OFF May 25 18:53:54 volumio volumio[3141]: info: CoreCommandRouter::volumioPlay May 25 18:53:54 volumio volumio[3141]: info: CoreStateMachine::play index undefined May 25 18:53:54 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:53:54 volumio volumio[3141]: info: CorePlayQueue::getTrack 17 May 25 18:53:54 volumio volumio[3141]: info: CoreStateMachine::startPlaybackTimer May 25 18:53:54 volumio volumio[3141]: info: CorePlayQueue::getTrack 17 May 25 18:54:00 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 25 18:54:00 volumio volumio[3141]: info: Preload queue cleared May 25 18:54:05 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 25 18:54:05 volumio volumio[3141]: info: TuneIn handleBrowseUri: tunein/popular May 25 18:54:06 volumio volumio[3141]: info: Preload queue cleared May 25 18:54:15 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 25 18:54:15 volumio volumio[3141]: info: Preload queue cleared May 25 18:54:22 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 25 18:54:23 volumio volumio[3141]: info: Preload queue cleared May 25 18:54:26 volumio volumio[3141]: info: Preload queue cleared May 25 18:54:26 volumio volumio[3141]: info: CoreCommandRouter::volumioReplaceandPlayItems May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::ClearQueue May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::stop May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:54:26 volumio volumio[3141]: info: CorePlayQueue::clearPlayQueue May 25 18:54:26 volumio volumio[3141]: info: CorePlayQueue::saveQueue May 25 18:54:26 volumio volumio[3141]: info: CoreCommandRouter::volumioPushQueue May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::addQueueItems May 25 18:54:26 volumio volumio[3141]: info: CorePlayQueue::addQueueItems May 25 18:54:26 volumio volumio[3141]: info: Preload queue cleared May 25 18:54:26 volumio volumio[3141]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 May 25 18:54:26 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 25 18:54:26 volumio volumio[3141]: info: CoreCommandRouter::volumioPushQueue May 25 18:54:26 volumio volumio[3141]: info: CorePlayQueue::saveQueue May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::updateTrackBlock May 25 18:54:26 volumio volumio[3141]: info: CorePlayQueue::getTrackBlock May 25 18:54:26 volumio volumio[3141]: info: CoreCommandRouter::volumioPlay May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::play index 0 May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::stop May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::play index undefined May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:54:26 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::startPlaybackTimer May 25 18:54:26 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:26 volumio volumio[3141]: info: [1779724466023] ControllerWebradio::clearAddPlayTrack May 25 18:54:26 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand stop May 25 18:54:26 volumio volumio[3141]: info: sendMpdCommand stop took 2 milliseconds May 25 18:54:26 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand clear May 25 18:54:26 volumio volumio[3141]: info: May 25 18:54:26 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:26 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:26 volumio volumio[3141]: info: sendMpdCommand clear took 0 milliseconds May 25 18:54:26 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" May 25 18:54:26 volumio volumio[3141]: info: May 25 18:54:26 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:26 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:26 volumio volumio[3141]: error: updateQueue error: null May 25 18:54:26 volumio volumio[3141]: info: ------------------------------ 1ms May 25 18:54:26 volumio volumio[3141]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 539 milliseconds May 25 18:54:26 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService mpd May 25 18:54:26 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand play May 25 18:54:26 volumio volumio[3141]: info: May 25 18:54:26 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:26 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:26 volumio volumio[3141]: info: ------------------------------ 539ms May 25 18:54:26 volumio volumio[3141]: info: May 25 18:54:26 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:26 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:26 volumio volumio[3141]: info: sendMpdCommand play took 1 milliseconds May 25 18:54:26 volumio volumio[3141]: info: ------------------------------ 1ms May 25 18:54:26 volumio volumio[3141]: info: ------------------------------ 0ms May 25 18:54:27 volumio volumio[3141]: info: Preload queue cleared May 25 18:54:27 volumio volumio[3141]: info: CoreCommandRouter::volumioReplaceandPlayItems May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::ClearQueue May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::stop May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:54:27 volumio volumio[3141]: info: CorePlayQueue::clearPlayQueue May 25 18:54:27 volumio volumio[3141]: info: CorePlayQueue::saveQueue May 25 18:54:27 volumio volumio[3141]: info: CoreCommandRouter::volumioPushQueue May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::addQueueItems May 25 18:54:27 volumio volumio[3141]: info: CorePlayQueue::addQueueItems May 25 18:54:27 volumio volumio[3141]: info: Preload queue cleared May 25 18:54:27 volumio volumio[3141]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 May 25 18:54:27 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 25 18:54:27 volumio volumio[3141]: info: CoreCommandRouter::volumioPushQueue May 25 18:54:27 volumio volumio[3141]: info: CorePlayQueue::saveQueue May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::updateTrackBlock May 25 18:54:27 volumio volumio[3141]: info: CorePlayQueue::getTrackBlock May 25 18:54:27 volumio volumio[3141]: info: CoreCommandRouter::volumioPlay May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::play index 0 May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::stop May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::play index undefined May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:54:27 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::startPlaybackTimer May 25 18:54:27 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:27 volumio volumio[3141]: info: [1779724467902] ControllerWebradio::clearAddPlayTrack May 25 18:54:27 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand stop May 25 18:54:27 volumio volumio[3141]: info: May 25 18:54:27 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:27 volumio volumio[3141]: info: sendMpdCommand stop took 3 milliseconds May 25 18:54:27 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:27 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:27 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand clear May 25 18:54:27 volumio volumio[3141]: info: May 25 18:54:27 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:27 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:27 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:27 volumio volumio[3141]: info: May 25 18:54:27 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:27 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:27 volumio volumio[3141]: info: sendMpdCommand status took 1 milliseconds May 25 18:54:27 volumio volumio[3141]: info: sendMpdCommand clear took 0 milliseconds May 25 18:54:27 volumio volumio[3141]: info: sendMpdCommand status took 0 milliseconds May 25 18:54:27 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:27 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:27 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" May 25 18:54:27 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:27 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:27 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:27 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:27 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:27 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:54:27 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:27 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:27 volumio volumio[3141]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 25 18:54:27 volumio volumio[3141]: info: ------------------------------ 7ms May 25 18:54:27 volumio volumio[3141]: info: May 25 18:54:27 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:27 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:27 volumio volumio[3141]: error: updateQueue error: null May 25 18:54:27 volumio volumio[3141]: info: ------------------------------ 8ms May 25 18:54:27 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 7 milliseconds May 25 18:54:27 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:27 volumio volumio[3141]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 25 18:54:27 volumio volumio[3141]: info: ------------------------------ 9ms May 25 18:54:27 volumio volumio[3141]: info: [ASDebug] CurState: stop PrevState: stop May 25 18:54:27 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status stop May 25 18:54:27 volumio sudo[4411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 25 18:54:27 volumio sudo[4411]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:27 volumio sudo[4411]: pam_unix(sudo:session): session closed for user root May 25 18:54:27 volumio volumio[3141]: info: peppymeterbasic Daemon Stop May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 135 milliseconds May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::setConsumeUpdateService mpd May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand play May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:28 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 130ms May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:28 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand play took 0 milliseconds May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 1ms May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 1ms May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:28 volumio volumio[3141]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 25 18:54:28 volumio volumio[3141]: info: FusionDsp - ---- read samplerate from file: 44100 May 25 18:54:28 volumio volumio[3141]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 25 18:54:28 volumio volumio[3141]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 25 18:54:28 volumio volumio[3141]: info: FusionDsp - ---- read samplerate from file: 44100 May 25 18:54:28 volumio volumio[3141]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand status took 10 milliseconds May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand status took 10 milliseconds May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand status took 2 milliseconds May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 1 milliseconds May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 1 milliseconds May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand status took 1 milliseconds May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 6265/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} May 25 18:54:28 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus stop May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 6265/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} May 25 18:54:28 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:54:28 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 17ms May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 26ms May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 15 milliseconds May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 15 milliseconds May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 6265/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} May 25 18:54:28 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:54:28 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 6265/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} May 25 18:54:28 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:54:28 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 44ms May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 44ms May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: stop May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] Togle GPIO: ON May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio sudo[4421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:28 volumio sudo[4421]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio sudo[4424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:28 volumio sudo[4424]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio sudo[4428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:28 volumio systemd[1]: Started peppymeterbasic Daemon. May 25 18:54:28 volumio sudo[4428]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:28 volumio sudo[4431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:28 volumio sudo[4431]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:28 volumio sudo[4421]: pam_unix(sudo:session): session closed for user root May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio sudo[4428]: pam_unix(sudo:session): session closed for user root May 25 18:54:28 volumio sudo[4435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:28 volumio sudo[4435]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:28 volumio sudo[4424]: pam_unix(sudo:session): session closed for user root May 25 18:54:28 volumio sudo[4431]: pam_unix(sudo:session): session closed for user root May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:28 volumio sudo[4435]: pam_unix(sudo:session): session closed for user root May 25 18:54:28 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:28 volumio sudo[4438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:28 volumio sudo[4438]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:28 volumio volumio[3141]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 25 18:54:28 volumio volumio[3141]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:28 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:28 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:28 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:28 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:28 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:28 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 9ms May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand status took 6 milliseconds May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 4ms May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand status took 3 milliseconds May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:28 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:28 volumio volumio[3141]: info: May 25 18:54:28 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:28 volumio sudo[4438]: pam_unix(sudo:session): session closed for user root May 25 18:54:28 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 17ms May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand status took 16 milliseconds May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 15 milliseconds May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 15 milliseconds May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 15ms May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand status took 14 milliseconds May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1737,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} May 25 18:54:28 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:54:28 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1737,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} May 25 18:54:28 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:54:28 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 42ms May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 40ms May 25 18:54:28 volumio volumio[3141]: info: touch_display: Setting screensaver timeout to 0 seconds. May 25 18:54:28 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 41 milliseconds May 25 18:54:28 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 41 milliseconds May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:28 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1737,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} May 25 18:54:28 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:54:28 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:28 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:28 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1737,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} May 25 18:54:28 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:54:28 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:28 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 76ms May 25 18:54:28 volumio volumio[3141]: info: ------------------------------ 73ms May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:28 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio sudo[4443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:28 volumio sudo[4443]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio sudo[4443]: pam_unix(sudo:session): session closed for user root May 25 18:54:28 volumio sudo[4446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:28 volumio sudo[4446]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio sudo[4449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:28 volumio sudo[4449]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:28 volumio sudo[4449]: pam_unix(sudo:session): session closed for user root May 25 18:54:28 volumio sudo[4446]: pam_unix(sudo:session): session closed for user root May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio sudo[4452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:28 volumio sudo[4452]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:28 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:28 volumio sudo[4452]: pam_unix(sudo:session): session closed for user root May 25 18:54:28 volumio sudo[4455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:29 volumio sudo[4455]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:29 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:29 volumio sudo[4458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:29 volumio sudo[4458]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:29 volumio sudo[4455]: pam_unix(sudo:session): session closed for user root May 25 18:54:29 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:29 volumio sudo[4458]: pam_unix(sudo:session): session closed for user root May 25 18:54:29 volumio sudo[4461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:29 volumio sudo[4461]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:29 volumio sudo[4461]: pam_unix(sudo:session): session closed for user root May 25 18:54:29 volumio sudo[4464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:29 volumio sudo[4464]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio sudo[4464]: pam_unix(sudo:session): session closed for user root May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio volumio[4425]: libpng warning: iCCP: known incorrect sRGB profile May 25 18:54:29 volumio volumio[4425]: libpng warning: iCCP: known incorrect sRGB profile May 25 18:54:29 volumio volumio[4425]: libpng warning: iCCP: known incorrect sRGB profile May 25 18:54:29 volumio volumio[3141]: info: May 25 18:54:29 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:29 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:29 volumio volumio[3141]: info: May 25 18:54:29 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:29 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:29 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:29 volumio volumio[3141]: info: May 25 18:54:29 volumio volumio[3141]: ---------------------------- MPD announces system playlist update May 25 18:54:29 volumio volumio[3141]: info: Ignoring MPD Status Update May 25 18:54:29 volumio volumio[3141]: info: May 25 18:54:29 volumio volumio[3141]: ---------------------------- MPD announces state update: player May 25 18:54:29 volumio volumio[3141]: info: ControllerMpd::getState May 25 18:54:29 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand status May 25 18:54:29 volumio volumio[3141]: info: ------------------------------ 2ms May 25 18:54:29 volumio volumio[3141]: info: sendMpdCommand status took 1 milliseconds May 25 18:54:29 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:29 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:29 volumio volumio[3141]: info: ------------------------------ 1ms May 25 18:54:29 volumio volumio[3141]: info: sendMpdCommand status took 1 milliseconds May 25 18:54:29 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 0 milliseconds May 25 18:54:29 volumio volumio[3141]: verbose: ControllerMpd::parseState May 25 18:54:29 volumio volumio[3141]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:54:29 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:29 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:29 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:29 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:29 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} May 25 18:54:29 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:54:29 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:54:29 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:54:29 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:54:29 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 18:54:29 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:29 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:54:29 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:29 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:29 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:29 volumio volumio[3141]: info: ------------------------------ 14ms May 25 18:54:29 volumio volumio[3141]: info: sendMpdCommand playlistinfo took 13 milliseconds May 25 18:54:29 volumio volumio[3141]: verbose: ControllerMpd::parseTrackInfo May 25 18:54:29 volumio volumio[3141]: info: ControllerMpd::pushState May 25 18:54:29 volumio volumio[3141]: info: CoreCommandRouter::servicePushState May 25 18:54:29 volumio volumio[3141]: info: CorePlayQueue::getTrack 0 May 25 18:54:29 volumio volumio[3141]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} May 25 18:54:29 volumio volumio[3141]: verbose: CURRENT POSITION 0 May 25 18:54:29 volumio volumio[3141]: info: CoreStateMachine::syncState stateService play May 25 18:54:29 volumio volumio[3141]: info: CoreStateMachine::syncState currentStatus play May 25 18:54:29 volumio volumio[3141]: info: Received an update from plugin. extracting info from payload May 25 18:54:29 volumio volumio[3141]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 18:54:29 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:29 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:29 volumio volumio[3141]: info: CoreStateMachine::pushState May 25 18:54:29 volumio volumio[3141]: info: CoreCommandRouter::volumioPushState May 25 18:54:29 volumio volumio[3141]: info: ------------------------------ 30ms May 25 18:54:29 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:29 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:29 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:29 volumio volumio[3141]: info: [ASDebug] CurState: play PrevState: play May 25 18:54:29 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:29 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:29 volumio sudo[4470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:29 volumio sudo[4470]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:29 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:29 volumio sudo[4470]: pam_unix(sudo:session): session closed for user root May 25 18:54:29 volumio sudo[4473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:29 volumio sudo[4473]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:29 volumio volumio[3141]: info: PeppyMeterBasic ---peppymeterbasic status play May 25 18:54:29 volumio sudo[4473]: pam_unix(sudo:session): session closed for user root May 25 18:54:29 volumio sudo[4476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:29 volumio sudo[4476]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio sudo[4479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service May 25 18:54:29 volumio sudo[4479]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:54:29 volumio sudo[4476]: pam_unix(sudo:session): session closed for user root May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:29 volumio sudo[4479]: pam_unix(sudo:session): session closed for user root May 25 18:54:29 volumio volumio[3141]: info: peppymeterbasic Daemon Started May 25 18:54:33 volumio volumio[3141]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 18:54:33 volumio volumio[3141]: TypeError: Cannot read property 'slice' of null May 25 18:54:33 volumio volumio[3141]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) May 25 18:54:33 volumio volumio[3141]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) May 25 18:54:33 volumio volumio[3141]: at Object.onceWrapper (events.js:422:26) May 25 18:54:33 volumio volumio[3141]: at ClientRequest.emit (events.js:315:20) May 25 18:54:33 volumio volumio[3141]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) May 25 18:54:33 volumio volumio[3141]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) May 25 18:54:33 volumio volumio[3141]: at TLSSocket.socketOnData (_http_client.js:509:22) May 25 18:54:33 volumio volumio[3141]: at TLSSocket.emit (events.js:315:20) May 25 18:54:33 volumio volumio[3141]: at addChunk (internal/streams/readable.js:309:12) May 25 18:54:33 volumio volumio[3141]: at readableAddChunk (internal/streams/readable.js:284:9) May 25 18:54:33 volumio volumio[3141]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) May 25 18:54:33 volumio volumio[3141]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) May 25 18:54:33 volumio volumio[3141]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 18:54:33 volumio sudo[4490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-25 18:53 May 25 18:54:33 volumio sudo[4490]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"