-- Logs begin at Sat 2024-11-30 20:02:11 CST, end at Sat 2024-11-30 20:26:09 CST. -- Nov 30 20:25:01 volumio volumio[6175]: info: Preload queue cleared Nov 30 20:25:03 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 30 20:25:03 volumio volumio[6175]: info: CURURI: playlists Nov 30 20:25:03 volumio volumio[6175]: info: Listing playlists Nov 30 20:25:03 volumio volumio[6175]: info: Preload queue cleared Nov 30 20:25:04 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 30 20:25:04 volumio volumio[6175]: info: CURURI: music-library Nov 30 20:25:04 volumio volumio[6175]: error: Failed LSINFO: null Nov 30 20:25:04 volumio volumio[6175]: info: Preload queue cleared Nov 30 20:25:07 volumio volumio[6175]: info: CoreCommandRouter::volumioGetState Nov 30 20:25:07 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:11 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:11 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , goto Nov 30 20:25:11 volumio volumio[6175]: info: Error : CoreCommandRouter::executeOnPlugin: No method [goto] in plugin upnp_browser Nov 30 20:25:16 volumio volumio[6175]: info: CoreCommandRouter::volumioGetState Nov 30 20:25:16 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPlay Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::play index undefined Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 20:25:48 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::startPlaybackTimer Nov 30 20:25:48 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:48 volumio volumio[6175]: info: [1732969548596] ControllerUPNPBrowser::clearAddPlayTrack Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand stop Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand stop took 2 milliseconds Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand clear Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces system playlist update Nov 30 20:25:48 volumio volumio[6175]: info: Ignoring MPD Status Update Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand clear took 1 milliseconds Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a" Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces system playlist update Nov 30 20:25:48 volumio volumio[6175]: info: Ignoring MPD Status Update Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces system playlist update Nov 30 20:25:48 volumio volumio[6175]: info: Ignoring MPD Status Update Nov 30 20:25:48 volumio volumio[6175]: error: updateQueue error: null Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 2ms Nov 30 20:25:48 volumio volumio[6175]: error: updateQueue error: null Nov 30 20:25:48 volumio volumio[6175]: error: updateQueue error: null Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a" Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 5ms Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 5ms Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces system playlist update Nov 30 20:25:48 volumio volumio[6175]: info: Ignoring MPD Status Update Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand add "http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a" took 1 milliseconds Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand play Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces system playlist update Nov 30 20:25:48 volumio volumio[6175]: info: Ignoring MPD Status Update Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces system playlist update Nov 30 20:25:48 volumio volumio[6175]: info: Ignoring MPD Status Update Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 2ms Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand play took 2 milliseconds Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 2ms Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 1ms Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces state update: player Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::getState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand status Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces state update: player Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::getState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand status Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces state update: player Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::getState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand status Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces state update: player Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand status took 3 milliseconds Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::getState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand status Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand status took 2 milliseconds Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand status took 1 milliseconds Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces state update: player Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::getState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand status Nov 30 20:25:48 volumio volumio[6175]: info: Nov 30 20:25:48 volumio volumio[6175]: ---------------------------- MPD announces state update: player Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::getState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand status Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand status took 3 milliseconds Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseTrackInfo Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseTrackInfo Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseTrackInfo Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::servicePushState Nov 30 20:25:48 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:48 volumio volumio[6175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01*20Tim*20McGraw.m4a","artist":null,"album":null,"uri":"http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a","trackType":"m4a"} Nov 30 20:25:48 volumio volumio[6175]: verbose: CURRENT POSITION 0 Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState stateService play Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState currentStatus stop Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::servicePushState Nov 30 20:25:48 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:48 volumio volumio[6175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01*20Tim*20McGraw.m4a","artist":null,"album":null,"uri":"http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a","trackType":"m4a"} Nov 30 20:25:48 volumio volumio[6175]: verbose: CURRENT POSITION 0 Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState stateService play Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState currentStatus play Nov 30 20:25:48 volumio volumio[6175]: info: Received an update from plugin. extracting info from payload Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::servicePushState Nov 30 20:25:48 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:48 volumio volumio[6175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01*20Tim*20McGraw.m4a","artist":null,"album":null,"uri":"http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a","trackType":"m4a"} Nov 30 20:25:48 volumio volumio[6175]: verbose: CURRENT POSITION 0 Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState stateService play Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState currentStatus play Nov 30 20:25:48 volumio volumio[6175]: info: Received an update from plugin. extracting info from payload Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 17ms Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 20ms Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 20ms Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand status took 17 milliseconds Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand status took 16 milliseconds Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand playlistinfo took 15 milliseconds Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseState Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseTrackInfo Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::servicePushState Nov 30 20:25:48 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:48 volumio volumio[6175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01*20Tim*20McGraw.m4a","artist":null,"album":null,"uri":"http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a","trackType":"m4a"} Nov 30 20:25:48 volumio volumio[6175]: verbose: CURRENT POSITION 0 Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState stateService play Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState currentStatus play Nov 30 20:25:48 volumio volumio[6175]: info: Received an update from plugin. extracting info from payload Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 26ms Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 30 20:25:48 volumio volumio[6175]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseTrackInfo Nov 30 20:25:48 volumio volumio[6175]: verbose: ControllerMpd::parseTrackInfo Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::servicePushState Nov 30 20:25:48 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:48 volumio volumio[6175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":753,"duration":232,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"01*20Tim*20McGraw.m4a","artist":null,"album":null,"uri":"http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a","trackType":"m4a"} Nov 30 20:25:48 volumio volumio[6175]: verbose: CURRENT POSITION 0 Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState stateService play Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState currentStatus play Nov 30 20:25:48 volumio volumio[6175]: info: Received an update from plugin. extracting info from payload Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:48 volumio volumio[6175]: info: ControllerMpd::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::servicePushState Nov 30 20:25:48 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:48 volumio volumio[6175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":823,"duration":232,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"01*20Tim*20McGraw.m4a","artist":null,"album":null,"uri":"http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a","trackType":"m4a"} Nov 30 20:25:48 volumio volumio[6175]: verbose: CURRENT POSITION 0 Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState stateService play Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::syncState currentStatus play Nov 30 20:25:48 volumio volumio[6175]: info: Received an update from plugin. extracting info from payload Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:48 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 34ms Nov 30 20:25:48 volumio volumio[6175]: info: ------------------------------ 33ms Nov 30 20:25:52 volumio volumio[6175]: info: CoreCommandRouter::volumioPause Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::pause Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::stPlaybackTimer Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::servicePause Nov 30 20:25:52 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:52 volumio volumio[6175]: info: CoreCommandRouter::servicePause Nov 30 20:25:52 volumio volumio[6175]: info: [1732969552174] ControllerUPNPBrowser::pause Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand pause Nov 30 20:25:52 volumio volumio[6175]: info: sendMpdCommand pause took 1 milliseconds Nov 30 20:25:52 volumio volumio[6175]: info: Nov 30 20:25:52 volumio volumio[6175]: ---------------------------- MPD announces state update: player Nov 30 20:25:52 volumio volumio[6175]: info: ControllerMpd::getState Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand status Nov 30 20:25:52 volumio volumio[6175]: info: Nov 30 20:25:52 volumio volumio[6175]: ---------------------------- MPD announces state update: player Nov 30 20:25:52 volumio volumio[6175]: info: ControllerMpd::getState Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand status Nov 30 20:25:52 volumio volumio[6175]: info: Nov 30 20:25:52 volumio volumio[6175]: ---------------------------- MPD announces state update: player Nov 30 20:25:52 volumio volumio[6175]: info: ControllerMpd::getState Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand status Nov 30 20:25:52 volumio volumio[6175]: info: sendMpdCommand status took 1 milliseconds Nov 30 20:25:52 volumio volumio[6175]: info: sendMpdCommand status took 1 milliseconds Nov 30 20:25:52 volumio volumio[6175]: info: sendMpdCommand status took 0 milliseconds Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::parseState Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::parseState Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::parseState Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 30 20:25:52 volumio volumio[6175]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 30 20:25:52 volumio volumio[6175]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 20:25:52 volumio volumio[6175]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::parseTrackInfo Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::parseTrackInfo Nov 30 20:25:52 volumio volumio[6175]: verbose: ControllerMpd::parseTrackInfo Nov 30 20:25:52 volumio volumio[6175]: info: ControllerMpd::pushState Nov 30 20:25:52 volumio volumio[6175]: info: CoreCommandRouter::servicePushState Nov 30 20:25:52 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:52 volumio volumio[6175]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4377,"duration":232,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"01*20Tim*20McGraw.m4a","artist":null,"album":null,"uri":"http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a","trackType":"m4a"} Nov 30 20:25:52 volumio volumio[6175]: verbose: CURRENT POSITION 0 Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::syncState stateService pause Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::syncState currentStatus pause Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:52 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 20:25:52 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::stPlaybackTimer Nov 30 20:25:52 volumio volumio[6175]: info: ControllerMpd::pushState Nov 30 20:25:52 volumio volumio[6175]: info: CoreCommandRouter::servicePushState Nov 30 20:25:52 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:52 volumio volumio[6175]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4377,"duration":232,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"01*20Tim*20McGraw.m4a","artist":null,"album":null,"uri":"http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a","trackType":"m4a"} Nov 30 20:25:52 volumio volumio[6175]: verbose: CURRENT POSITION 0 Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::syncState stateService pause Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::syncState currentStatus pause Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:52 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::stPlaybackTimer Nov 30 20:25:52 volumio volumio[6175]: info: ControllerMpd::pushState Nov 30 20:25:52 volumio volumio[6175]: info: CoreCommandRouter::servicePushState Nov 30 20:25:52 volumio volumio[6175]: info: CorePlayQueue::getTrack 0 Nov 30 20:25:52 volumio volumio[6175]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4377,"duration":232,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"01*20Tim*20McGraw.m4a","artist":null,"album":null,"uri":"http://192.168.31.43:9790/minimserver/*/MUSIC/Taylor*20Swift/Taylor*20Swift/01*20Tim*20McGraw.m4a","trackType":"m4a"} Nov 30 20:25:52 volumio volumio[6175]: verbose: CURRENT POSITION 0 Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::syncState stateService pause Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::syncState currentStatus pause Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::pushState Nov 30 20:25:52 volumio volumio[6175]: info: CoreCommandRouter::volumioPushState Nov 30 20:25:52 volumio volumio[6175]: info: CoreStateMachine::stPlaybackTimer Nov 30 20:25:52 volumio volumio[6175]: info: ------------------------------ 10ms Nov 30 20:25:52 volumio volumio[6175]: info: ------------------------------ 10ms Nov 30 20:25:52 volumio volumio[6175]: info: ------------------------------ 9ms Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 20:25:55 volumio volumio[6175]: info: Retrieving Cloud Streaming UI Nov 30 20:25:55 volumio volumio[6175]: info: Getting Tidal Cloud Configuration Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 20:25:55 volumio volumio[6175]: info: Getting Qobuz Cloud Configuration Nov 30 20:25:55 volumio volumio[6175]: info: Asking plugin for UI Config Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 20:25:55 volumio volumio[6175]: info: Getting Spotify Cloud Configuration Nov 30 20:25:55 volumio volumio[6175]: info: Asking plugin for UI Config Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 20:25:55 volumio volumio[6175]: info: Saving Spotify Acccount Nov 30 20:25:55 volumio volumio[6175]: info: Got Tidal Cloud Configuration Nov 30 20:25:55 volumio volumio[6175]: info: Got it Nov 30 20:25:55 volumio volumio[6175]: info: Got it Nov 30 20:25:55 volumio volumio[6175]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 20:25:55 volumio volumio[6175]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::volumioGetBrowseSources Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::volumioGetBrowseSources Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::volumioGetBrowseSources Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 30 20:25:55 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 30 20:25:59 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 30 20:26:00 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 30 20:26:00 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 30 20:26:01 volumio volumio[6175]: info: Error browsing device SA6400 for shares : Error: Command failed: echo volumio | smbclient -L SA6400.local. Nov 30 20:26:01 volumio volumio[6175]: Unable to initialize messaging context Nov 30 20:26:03 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 30 20:26:07 volumio volumio[6175]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 30 20:26:09 volumio volumio[6175]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 20:26:09 volumio volumio[6175]: Error: connect ETIMEDOUT 31.13.81.4:443 Nov 30 20:26:09 volumio volumio[6175]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Nov 30 20:26:09 volumio volumio[6175]: errno: -110, Nov 30 20:26:09 volumio volumio[6175]: code: 'ETIMEDOUT', Nov 30 20:26:09 volumio volumio[6175]: syscall: 'connect', Nov 30 20:26:09 volumio volumio[6175]: address: '31.13.81.4', Nov 30 20:26:09 volumio volumio[6175]: port: 443 Nov 30 20:26:09 volumio volumio[6175]: } Nov 30 20:26:09 volumio volumio[6175]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 20:26:09 volumio sudo[6765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-30 20:25 Nov 30 20:26:09 volumio sudo[6765]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"