-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2025-12-28 09:50:42 CET. -- Dec 28 09:49:01 volumio volumio[893]: verbose: New Socket.io Connection to 192.168.1.15:3000 from 192.168.1.82 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 28 09:49:01 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:01 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:01 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:01 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:01 volumio volumio[893]: info: CorePlayQueue::getTrack 9 Dec 28 09:49:01 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:02 volumio volumio[893]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.82 UA: Mozilla/5.0 (Linux; Android 14; 22101316G Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::volumioGetVisibleSources Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:02 volumio volumio[893]: info: CorePlayQueue::getTrack 9 Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::volumioGetQueue Dec 28 09:49:02 volumio volumio[893]: info: CoreStateMachine::getQueue Dec 28 09:49:02 volumio volumio[893]: info: CorePlayQueue::getQueue Dec 28 09:49:02 volumio volumio[893]: info: Listing playlists Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 28 09:49:02 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:02 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:02 volumio volumio[893]: info: CorePlayQueue::getTrack 9 Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:02 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:02 volumio volumio[893]: info: CorePlayQueue::getTrack 9 Dec 28 09:49:10 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 28 09:49:10 volumio volumio[893]: info: Preload queue cleared Dec 28 09:49:10 volumio go-librespot[1294]: time="2025-12-28T09:49:10+01:00" level=trace msg="sent dealer ping" Dec 28 09:49:10 volumio go-librespot[1294]: time="2025-12-28T09:49:10+01:00" level=trace msg="received dealer pong" Dec 28 09:49:11 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 28 09:49:11 volumio volumio[893]: info: Preload queue cleared Dec 28 09:49:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 28 09:49:14 volumio volumio[893]: info: Preload queue cleared Dec 28 09:49:16 volumio volumio[893]: info: Preload queue cleared Dec 28 09:49:16 volumio volumio[893]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::ClearQueue Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::stop Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 28 09:49:16 volumio volumio[893]: info: CorePlayQueue::clearPlayQueue Dec 28 09:49:16 volumio volumio[893]: info: CorePlayQueue::saveQueue Dec 28 09:49:16 volumio volumio[893]: info: CoreCommandRouter::volumioPushQueue Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::addQueueItems Dec 28 09:49:16 volumio volumio[893]: info: CorePlayQueue::addQueueItems Dec 28 09:49:16 volumio volumio[893]: info: Preload queue cleared Dec 28 09:49:16 volumio volumio[893]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s174766 Dec 28 09:49:16 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 28 09:49:16 volumio volumio[893]: info: CoreCommandRouter::volumioPushQueue Dec 28 09:49:16 volumio volumio[893]: info: CorePlayQueue::saveQueue Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::updateTrackBlock Dec 28 09:49:16 volumio volumio[893]: info: CorePlayQueue::getTrackBlock Dec 28 09:49:16 volumio volumio[893]: info: CoreCommandRouter::volumioPlay Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::play index 0 Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::stop Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::play index undefined Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 28 09:49:16 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:16 volumio volumio[893]: info: CoreStateMachine::startPlaybackTimer Dec 28 09:49:16 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:16 volumio volumio[893]: info: [1766911756501] ControllerWebradio::clearAddPlayTrack Dec 28 09:49:16 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand stop Dec 28 09:49:16 volumio volumio[893]: info: sendMpdCommand stop took 7 milliseconds Dec 28 09:49:16 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand clear Dec 28 09:49:16 volumio volumio[893]: info: sendMpdCommand clear took 1 milliseconds Dec 28 09:49:16 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand load "http://stream.rcs.revma.com/ypqt40u0x1zuv" Dec 28 09:49:16 volumio volumio[893]: info: Dec 28 09:49:16 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:16 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:16 volumio volumio[893]: info: Dec 28 09:49:16 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:16 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:16 volumio volumio[893]: info: Dec 28 09:49:16 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:16 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:16 volumio volumio[893]: error: Upnp client error: Error: This socket has been ended by the other party Dec 28 09:49:18 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand add "http://stream.rcs.revma.com/ypqt40u0x1zuv" Dec 28 09:49:18 volumio volumio[893]: error: updateQueue error: null Dec 28 09:49:18 volumio volumio[893]: error: updateQueue error: null Dec 28 09:49:18 volumio volumio[893]: error: updateQueue error: null Dec 28 09:49:18 volumio volumio[893]: info: ------------------------------ 1802ms Dec 28 09:49:18 volumio volumio[893]: info: ------------------------------ 1799ms Dec 28 09:49:18 volumio volumio[893]: info: ------------------------------ 1797ms Dec 28 09:49:18 volumio volumio[893]: info: Dec 28 09:49:18 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:18 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:18 volumio volumio[893]: info: sendMpdCommand add "http://stream.rcs.revma.com/ypqt40u0x1zuv" took 6 milliseconds Dec 28 09:49:18 volumio volumio[893]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 28 09:49:18 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand play Dec 28 09:49:18 volumio volumio[893]: info: Dec 28 09:49:18 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:18 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:18 volumio volumio[893]: info: Dec 28 09:49:18 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:18 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:18 volumio volumio[893]: info: ------------------------------ 9ms Dec 28 09:49:18 volumio volumio[893]: info: sendMpdCommand play took 7 milliseconds Dec 28 09:49:18 volumio volumio[893]: info: ------------------------------ 7ms Dec 28 09:49:18 volumio volumio[893]: info: ------------------------------ 5ms Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 19 milliseconds Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 23 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 21 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: 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":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus stop Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 37ms Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 16 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 13 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 4 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 3 milliseconds Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: 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":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: 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":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 104ms Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 105ms Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:19 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 69 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 68 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 67 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: 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":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: 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":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: 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":"ypqt40u0x1zuv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 177ms Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 165ms Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 164ms Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:19 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:19 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:19 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 142ms Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 140 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 11ms Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 9 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 9ms Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 7 milliseconds Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:19 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces system playlist update Dec 28 09:49:19 volumio volumio[893]: info: Ignoring MPD Status Update Dec 28 09:49:19 volumio volumio[893]: info: Dec 28 09:49:19 volumio volumio[893]: ---------------------------- MPD announces state update: player Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::getState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand status Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 15ms Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 13 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 8ms Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 8 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 7ms Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand status took 6 milliseconds Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseState Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio Nowy Świat - Pion i poziom!","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio Nowy Świat - Pion i poziom!","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio Nowy Świat - Pion i poziom!","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 248ms Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 117ms Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 115ms Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 96 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 95 milliseconds Dec 28 09:49:19 volumio volumio[893]: info: sendMpdCommand playlistinfo took 96 milliseconds Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: verbose: ControllerMpd::parseTrackInfo Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio Nowy Świat - Pion i poziom!","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio Nowy Świat - Pion i poziom!","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ControllerMpd::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::servicePushState Dec 28 09:49:19 volumio volumio[893]: info: CorePlayQueue::getTrack 0 Dec 28 09:49:19 volumio volumio[893]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio Nowy Świat - Pion i poziom!","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Dec 28 09:49:19 volumio volumio[893]: verbose: CURRENT POSITION 0 Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState stateService play Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::syncState currentStatus play Dec 28 09:49:19 volumio volumio[893]: info: Received an update from plugin. extracting info from payload Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:49:19 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 189ms Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 182ms Dec 28 09:49:19 volumio volumio[893]: info: ------------------------------ 181ms Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:19 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Dec 28 09:49:37 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 28 09:49:37 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 28 09:49:38 volumio sudo[2196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 28 09:49:38 volumio sudo[2196]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 28 09:49:38 volumio sudo[2196]: pam_unix(sudo:session): session closed for user root Dec 28 09:49:38 volumio sudo[2198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 28 09:49:38 volumio sudo[2198]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 28 09:49:38 volumio sudo[2198]: pam_unix(sudo:session): session closed for user root Dec 28 09:49:39 volumio volumio[893]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.82 UA: Mozilla/5.0 (Linux; Android 14; 22101316G Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::volumioGetVisibleSources Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 28 09:49:39 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:39 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:39 volumio volumio[893]: info: Listing playlists Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 28 09:49:39 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 28 09:49:40 volumio sudo[2206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 28 09:49:40 volumio sudo[2206]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 28 09:49:40 volumio sudo[2206]: pam_unix(sudo:session): session closed for user root Dec 28 09:49:40 volumio sudo[2208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 28 09:49:40 volumio sudo[2208]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 28 09:49:40 volumio sudo[2208]: pam_unix(sudo:session): session closed for user root Dec 28 09:49:40 volumio go-librespot[1294]: time="2025-12-28T09:49:40+01:00" level=trace msg="sent dealer ping" Dec 28 09:49:40 volumio volumio[893]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.82 UA: Mozilla/5.0 (Linux; Android 14; 22101316G Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Dec 28 09:49:40 volumio go-librespot[1294]: time="2025-12-28T09:49:40+01:00" level=trace msg="received dealer pong" Dec 28 09:49:40 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::volumioGetVisibleSources Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::volumioGetQueue Dec 28 09:49:41 volumio volumio[893]: info: CoreStateMachine::getQueue Dec 28 09:49:41 volumio volumio[893]: info: CorePlayQueue::getQueue Dec 28 09:49:41 volumio volumio[893]: info: Listing playlists Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 28 09:49:41 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:41 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 28 09:49:41 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 28 09:49:42 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 28 09:49:42 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:42 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:42 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:42 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:42 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:42 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:42 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 28 09:49:42 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 28 09:49:45 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 28 09:49:45 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:45 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:45 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:45 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:45 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:45 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:45 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 28 09:49:45 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:45 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:45 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:45 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:45 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:45 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:46 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 28 09:49:46 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:46 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:46 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:46 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:46 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:46 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:47 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 28 09:49:48 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:48 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:48 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:48 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:48 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:48 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:48 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 28 09:49:48 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 28 09:49:49 volumio sudo[2249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 28 09:49:49 volumio sudo[2249]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 28 09:49:49 volumio sudo[2249]: pam_unix(sudo:session): session closed for user root Dec 28 09:49:49 volumio sudo[2251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 28 09:49:49 volumio sudo[2251]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 28 09:49:49 volumio sudo[2251]: pam_unix(sudo:session): session closed for user root Dec 28 09:49:49 volumio volumio[893]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.82 UA: Mozilla/5.0 (Linux; Android 14; 22101316G Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Dec 28 09:49:49 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 28 09:49:50 volumio sudo[2257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 28 09:49:50 volumio sudo[2257]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 28 09:49:50 volumio sudo[2257]: pam_unix(sudo:session): session closed for user root Dec 28 09:49:50 volumio sudo[2260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 28 09:49:50 volumio sudo[2260]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 28 09:49:50 volumio sudo[2260]: pam_unix(sudo:session): session closed for user root Dec 28 09:49:50 volumio volumio[893]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.82 UA: Mozilla/5.0 (Linux; Android 14; 22101316G Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::volumioGetVisibleSources Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::volumioGetQueue Dec 28 09:49:50 volumio volumio[893]: info: CoreStateMachine::getQueue Dec 28 09:49:50 volumio volumio[893]: info: CorePlayQueue::getQueue Dec 28 09:49:50 volumio volumio[893]: info: Listing playlists Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 28 09:49:50 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:50 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 28 09:49:50 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 28 09:49:51 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 28 09:49:51 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 28 09:49:52 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 28 09:49:52 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:52 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:52 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:52 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:52 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:52 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:49:52 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 28 09:49:53 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 28 09:49:53 volumio volumio[893]: info: Received Get System Info Dec 28 09:49:53 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:49:53 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:49:53 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:49:53 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:49:53 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:50:00 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 28 09:50:00 volumio volumio[893]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 28 09:50:00 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 28 09:50:00 volumio volumio[893]: info: Received Get System Version Dec 28 09:50:00 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 28 09:50:00 volumio volumio[893]: info: Received Get System Info Dec 28 09:50:00 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:50:00 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:50:00 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:50:00 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:50:00 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:50:00 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 28 09:50:08 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 28 09:50:08 volumio volumio[893]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 28 09:50:08 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 28 09:50:08 volumio volumio[893]: info: Received Get System Version Dec 28 09:50:08 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 28 09:50:08 volumio volumio[893]: info: Received Get System Info Dec 28 09:50:08 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 28 09:50:08 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 28 09:50:08 volumio volumio[893]: info: Discovery: Getting this device information Dec 28 09:50:08 volumio volumio[893]: info: CoreCommandRouter::volumioGetState Dec 28 09:50:08 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 28 09:50:10 volumio go-librespot[1294]: time="2025-12-28T09:50:10+01:00" level=trace msg="sent dealer ping" Dec 28 09:50:11 volumio go-librespot[1294]: time="2025-12-28T09:50:11+01:00" level=trace msg="received dealer pong" Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 28 09:50:14 volumio volumio[893]: info: Getting Alsa Cards List without I2S DAC Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 28 09:50:14 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 28 09:50:26 volumio volumio[893]: info: VolumeController::SetAlsaVolume- Dec 28 09:50:26 volumio volumio[893]: info: CoreStateMachine::pushState Dec 28 09:50:26 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 28 09:50:26 volumio volumio[893]: info: CoreCommandRouter::volumioPushState Dec 28 09:50:26 volumio volumio[893]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Dec 28 09:50:26 volumio volumio[893]: SPOTIFY: SPOTIFY VOLUME 70 Dec 28 09:50:26 volumio volumio[893]: SPOTIFY: VOLUMIO VOLUME 65 Dec 28 09:50:26 volumio volumio[893]: SPOTIFY: DELTA VOLUME ENOUGH: true Dec 28 09:50:26 volumio volumio[893]: info: Setting Spotify Volume from Volumio: 65 Dec 28 09:50:26 volumio volumio[893]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 28 09:50:27 volumio volumio[893]: info: Getting Alsa Cards List without I2S DAC Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 28 09:50:27 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 28 09:50:28 volumio volumio[893]: SPOTIFY: SETTING SPOTIFY VOLUME 65 Dec 28 09:50:28 volumio volumio[893]: info: Sending Spotify command with payload to local API: /player/volume Dec 28 09:50:28 volumio go-librespot[1294]: time="2025-12-28T09:50:28+01:00" level=debug msg="update volume requested to 42597/65535" Dec 28 09:50:28 volumio go-librespot[1294]: time="2025-12-28T09:50:28+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 28 09:50:28 volumio go-librespot[1294]: time="2025-12-28T09:50:28+01:00" level=trace msg="emitting websocket event: volume" Dec 28 09:50:28 volumio volumio[893]: SPOTIFY: received: {"type":"volume","data":{"value":65,"max":100}} Dec 28 09:50:28 volumio volumio[893]: SPOTIFY: RECEIVED SPOTIFY VOLUME 65 Dec 28 09:50:39 volumio go-librespot[1294]: time="2025-12-28T09:50:39+01:00" level=trace msg="received accesspoint ping" Dec 28 09:50:39 volumio go-librespot[1294]: time="2025-12-28T09:50:39+01:00" level=trace msg="received accesspoint pong ack" Dec 28 09:50:40 volumio go-librespot[1294]: time="2025-12-28T09:50:40+01:00" level=trace msg="sent dealer ping" Dec 28 09:50:40 volumio go-librespot[1294]: time="2025-12-28T09:50:40+01:00" level=trace msg="received dealer pong" Dec 28 09:50:42 volumio volumio[893]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ Dec 28 09:50:42 volumio volumio[893]: info: PLUGIN onShutdown : networkfs Dec 28 09:50:42 volumio volumio[893]: info: PLUGIN onShutdown : audiophonicsonoff Dec 28 09:50:42 volumio volumio[893]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 28 09:50:42 volumio volumio[893]: TypeError: Cannot read property 'writeSync' of undefined Dec 28 09:50:42 volumio volumio[893]: at ControllerAudiophonicsOnOff.onVolumioShutdown (/data/plugins/system_controller/audiophonicsonoff/index.js:43:25) Dec 28 09:50:42 volumio volumio[893]: at PluginManager.onVolumioShutdownPlugin (/volumio/app/pluginmanager.js:638:30) Dec 28 09:50:42 volumio volumio[893]: at HashMap. (/volumio/app/pluginmanager.js:621:31) Dec 28 09:50:42 volumio volumio[893]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Dec 28 09:50:42 volumio volumio[893]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Dec 28 09:50:42 volumio volumio[893]: at PluginManager.onVolumioShutdown (/volumio/app/pluginmanager.js:619:20) Dec 28 09:50:42 volumio volumio[893]: at CoreCommandRouter.shutdown (/volumio/app/index.js:1328:22) Dec 28 09:50:42 volumio volumio[893]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:859:33) Dec 28 09:50:42 volumio volumio[893]: at Socket.emit (events.js:315:20) Dec 28 09:50:42 volumio volumio[893]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 28 09:50:42 volumio volumio[893]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Dec 28 09:50:42 volumio volumio[893]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 28 09:50:42 volumio sudo[2518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-28 09:49 Dec 28 09:50:42 volumio sudo[2518]: 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="5d50cd80bebce60dddccd7f5e813d656e28ca4cd" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="7840f283c310c38bfe939a4c485727a6ff6a0ce1" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 21 Oct 2025 03:46:47 PM CEST" VOLUMIO_VERSION="3.866" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e2f3a8aca3147ba51b5da8167dd6ff8"