-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2025-05-01 12:59:57 CST. -- May 01 12:58:00 volumio volumio[1019]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 May 01 12:58:01 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:58:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 01 12:58:01 volumio volumio[1019]: info: Getting webradio selection May 01 12:58:01 volumio volumio[1019]: info: Preload queue cleared May 01 12:58:03 volumio volumio[1019]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 May 01 12:58:03 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:07 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:58:13 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:58:18 volumio volumio[1019]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 01 12:58:18 volumio volumio[1019]: info: Retrying Login Due to Network Error May 01 12:58:19 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:58:20 volumio volumio[1019]: info: Preload queue cleared May 01 12:58:20 volumio volumio[1019]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::ClearQueue May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::stop May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::stPlaybackTimer May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock May 01 12:58:20 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:20 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:20 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:58:20 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::serviceStop May 01 12:58:20 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:20 volumio volumio[1019]: info: CoreCommandRouter::serviceStop May 01 12:58:20 volumio volumio[1019]: info: [1746075500617] ControllerWebradio::stop May 01 12:58:20 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop May 01 12:58:20 volumio volumio[1019]: info: CorePlayQueue::clearPlayQueue May 01 12:58:20 volumio volumio[1019]: info: CorePlayQueue::saveQueue May 01 12:58:20 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::addQueueItems May 01 12:58:20 volumio volumio[1019]: info: CorePlayQueue::addQueueItems May 01 12:58:20 volumio volumio[1019]: info: Preload queue cleared May 01 12:58:20 volumio volumio[1019]: info: Adding Item to queue: https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3 May 01 12:58:20 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 01 12:58:20 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue May 01 12:58:20 volumio volumio[1019]: info: CorePlayQueue::saveQueue May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock May 01 12:58:20 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock May 01 12:58:20 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::play index 0 May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::stop May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::play index undefined May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:58:20 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:20 volumio volumio[1019]: info: CoreStateMachine::startPlaybackTimer May 01 12:58:20 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:20 volumio volumio[1019]: info: [1746075500650] ControllerWebradio::clearAddPlayTrack May 01 12:58:20 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop May 01 12:58:20 volumio volumio[1019]: info: May 01 12:58:20 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:20 volumio volumio[1019]: info: sendMpdCommand stop took 83 milliseconds May 01 12:58:20 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:20 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:20 volumio volumio[1019]: info: sendMpdCommand stop took 50 milliseconds May 01 12:58:20 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clear May 01 12:58:20 volumio volumio[1019]: info: May 01 12:58:20 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:20 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:20 volumio volumio[1019]: info: sendMpdCommand status took 14 milliseconds May 01 12:58:20 volumio volumio[1019]: info: sendMpdCommand clear took 14 milliseconds May 01 12:58:20 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:20 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:20 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" May 01 12:58:20 volumio volumio[1019]: info: May 01 12:58:20 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:20 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:20 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:20 volumio volumio[1019]: error: updateQueue error: null May 01 12:58:20 volumio volumio[1019]: info: ------------------------------ 12ms May 01 12:58:20 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 12 milliseconds May 01 12:58:20 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:20 volumio volumio[1019]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 12:58:20 volumio volumio[1019]: info: ------------------------------ 33ms May 01 12:58:20 volumio volumio[1019]: info: touch_display: Setting screensaver timeout to 120 seconds. May 01 12:58:23 volumio volumio[1019]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 May 01 12:58:23 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:23 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:25 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:58:28 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" May 01 12:58:28 volumio volumio[1019]: info: May 01 12:58:28 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:28 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:28 volumio volumio[1019]: info: sendMpdCommand status took 7764 milliseconds May 01 12:58:28 volumio volumio[1019]: info: sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" took 1 milliseconds May 01 12:58:28 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:28 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService mpd May 01 12:58:28 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand play May 01 12:58:28 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:28 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:28 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:28 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:58:28 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:28 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:28 volumio volumio[1019]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 12:58:28 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:28 volumio volumio[1019]: info: CoreStateMachine::syncState stateService stop May 01 12:58:28 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop May 01 12:58:28 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:28 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:28 volumio volumio[1019]: info: No code May 01 12:58:28 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:28 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:28 volumio volumio[1019]: info: ------------------------------ 7802ms May 01 12:58:28 volumio volumio[1019]: Upnp client error: Error: This socket has been ended by the other party May 01 12:58:28 volumio volumio[1019]: Upnp client error: Error: This socket has been ended by the other party May 01 12:58:28 volumio volumio[1019]: info: May 01 12:58:28 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:28 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:28 volumio volumio[1019]: Upnp client error: Error: This socket has been ended by the other party May 01 12:58:28 volumio volumio[1019]: info: ------------------------------ 47ms May 01 12:58:28 volumio volumio[1019]: info: sendMpdCommand play took 46 milliseconds May 01 12:58:28 volumio volumio[1019]: info: ------------------------------ 4ms May 01 12:58:28 volumio volumio[1019]: info: May 01 12:58:28 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:28 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:28 volumio volumio[1019]: info: ------------------------------ 41ms May 01 12:58:28 volumio volumio[1019]: info: touch_display: Setting screensaver timeout to 0 seconds. May 01 12:58:28 volumio volumio[1019]: info: MyVolumio login type: Token May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:58:29 volumio volumio[1019]: info: Retrieving Cloud Streaming UI May 01 12:58:29 volumio volumio[1019]: info: Getting Tidal Cloud Configuration May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:58:29 volumio volumio[1019]: info: Getting Qobuz Cloud Configuration May 01 12:58:29 volumio volumio[1019]: info: Asking plugin for UI Config May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:58:29 volumio volumio[1019]: info: Getting Spotify Cloud Configuration May 01 12:58:29 volumio volumio[1019]: info: Asking plugin for UI Config May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:58:29 volumio volumio[1019]: info: Saving Spotify Acccount May 01 12:58:29 volumio volumio[1019]: info: Got Tidal Cloud Configuration May 01 12:58:29 volumio volumio[1019]: info: Got it May 01 12:58:29 volumio volumio[1019]: info: Got it May 01 12:58:29 volumio volumio[1019]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:58:29 volumio volumio[1019]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::volumioGetBrowseSources May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::volumioGetBrowseSources May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::volumioGetBrowseSources May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:58:29 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 01 12:58:31 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:58:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:58:34 volumio volumio[1019]: info: May 01 12:58:34 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:34 volumio volumio[1019]: info: May 01 12:58:34 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:34 volumio volumio[1019]: info: May 01 12:58:34 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand status took 8 milliseconds May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand status took 7 milliseconds May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand status took 2 milliseconds May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 3 milliseconds May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 4 milliseconds May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:34 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:34 volumio volumio[1019]: 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":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:34 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:34 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:34 volumio volumio[1019]: 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":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:34 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:34 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:34 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:34 volumio volumio[1019]: info: ------------------------------ 26ms May 01 12:58:34 volumio volumio[1019]: info: ------------------------------ 41ms May 01 12:58:34 volumio volumio[1019]: info: May 01 12:58:34 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 29 milliseconds May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand status took 3 milliseconds May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:34 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:34 volumio volumio[1019]: 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":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:34 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:34 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:34 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:34 volumio volumio[1019]: info: ------------------------------ 92ms May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 78 milliseconds May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:34 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:34 volumio volumio[1019]: 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":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:34 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:34 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:34 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:34 volumio volumio[1019]: info: ------------------------------ 122ms May 01 12:58:34 volumio volumio[1019]: info: May 01 12:58:34 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:34 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:34 volumio volumio[1019]: info: May 01 12:58:34 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:34 volumio volumio[1019]: info: May 01 12:58:34 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:34 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:34 volumio volumio[1019]: info: May 01 12:58:34 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:34 volumio volumio[1019]: info: ------------------------------ 4ms May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand status took 4 milliseconds May 01 12:58:34 volumio volumio[1019]: info: ------------------------------ 3ms May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand status took 2 milliseconds May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 2 milliseconds May 01 12:58:34 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 1 milliseconds May 01 12:58:34 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:34 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:34 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JASON DERULO & NUKA - LOVE NOT WAR (THE TAMPA BEAT)","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:34 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:34 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:34 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:34 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:34 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JASON DERULO & NUKA - LOVE NOT WAR (THE TAMPA BEAT)","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:34 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:34 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:34 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:34 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:34 volumio volumio[1019]: info: ------------------------------ 60ms May 01 12:58:34 volumio volumio[1019]: info: ------------------------------ 59ms May 01 12:58:37 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:58:37 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:58:38 volumio volumio[1019]: info: Enabling MyMusic plugin bluetooth May 01 12:58:38 volumio volumio[1019]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth May 01 12:58:38 volumio volumio[1019]: info: [MyVolumio PluginManager] Plugin audio_interface bluetooth not in user plan, not enabling May 01 12:58:38 volumio volumio[1019]: info: Error: Plugin audio_interface bluetooth not in user plan, not enabling May 01 12:58:38 volumio volumio[1019]: error: Could not Enable MyMusic Plugin: Error May 01 12:58:38 volumio volumio[1019]: info: May 01 12:58:38 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:38 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:38 volumio volumio[1019]: info: May 01 12:58:38 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:38 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:38 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:38 volumio volumio[1019]: info: May 01 12:58:38 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:38 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:38 volumio volumio[1019]: info: May 01 12:58:38 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:38 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:38 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:38 volumio volumio[1019]: info: ------------------------------ 4ms May 01 12:58:38 volumio volumio[1019]: info: sendMpdCommand status took 4 milliseconds May 01 12:58:38 volumio volumio[1019]: info: ------------------------------ 3ms May 01 12:58:38 volumio volumio[1019]: info: sendMpdCommand status took 3 milliseconds May 01 12:58:38 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:38 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:38 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:38 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:38 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 2 milliseconds May 01 12:58:38 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 2 milliseconds May 01 12:58:38 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:38 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:38 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:38 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:38 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:38 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2496,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JASON DERULO & NUKA - LOVE NOT WAR (THE TAMPA BEAT)","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:38 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:38 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:38 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:38 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:38 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:38 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:58:38 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:38 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:38 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:38 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:38 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:38 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:38 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2496,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JASON DERULO & NUKA - LOVE NOT WAR (THE TAMPA BEAT)","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:38 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:38 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:38 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:38 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:38 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:38 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:38 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:38 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:38 volumio volumio[1019]: info: ------------------------------ 57ms May 01 12:58:38 volumio volumio[1019]: info: ------------------------------ 57ms May 01 12:58:41 volumio volumio[1019]: info: May 01 12:58:41 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:41 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:41 volumio volumio[1019]: info: May 01 12:58:41 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:41 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:41 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:41 volumio volumio[1019]: info: May 01 12:58:41 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:41 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:41 volumio volumio[1019]: info: May 01 12:58:41 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:41 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:41 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:41 volumio volumio[1019]: info: ------------------------------ 6ms May 01 12:58:41 volumio volumio[1019]: info: sendMpdCommand status took 5 milliseconds May 01 12:58:41 volumio volumio[1019]: info: ------------------------------ 4ms May 01 12:58:41 volumio volumio[1019]: info: sendMpdCommand status took 2 milliseconds May 01 12:58:41 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:41 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:41 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:41 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:41 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 1 milliseconds May 01 12:58:41 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 2 milliseconds May 01 12:58:41 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:41 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:41 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:41 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:41 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:41 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3355,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JASON DERULO & NUKA - LOVE NOT WAR (THE TAMPA BEAT)","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:41 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:41 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:41 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:41 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:41 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:41 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:58:41 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:41 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:41 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:41 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:41 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:41 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:41 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3515,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JASON DERULO & NUKA - LOVE NOT WAR (THE TAMPA BEAT)","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:41 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:41 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:41 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:41 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:41 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:41 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:41 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:41 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:41 volumio volumio[1019]: info: ------------------------------ 58ms May 01 12:58:41 volumio volumio[1019]: info: ------------------------------ 56ms May 01 12:58:41 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:58:42 volumio volumio[1019]: info: May 01 12:58:42 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:42 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:42 volumio volumio[1019]: info: May 01 12:58:42 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:42 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:42 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:42 volumio volumio[1019]: info: May 01 12:58:42 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:58:42 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:58:42 volumio volumio[1019]: info: May 01 12:58:42 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:58:42 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:58:42 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:58:42 volumio volumio[1019]: info: ------------------------------ 8ms May 01 12:58:42 volumio volumio[1019]: info: sendMpdCommand status took 4 milliseconds May 01 12:58:42 volumio volumio[1019]: info: ------------------------------ 3ms May 01 12:58:42 volumio volumio[1019]: info: sendMpdCommand status took 2 milliseconds May 01 12:58:42 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:42 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:42 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:58:42 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:58:42 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 1 milliseconds May 01 12:58:42 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 2 milliseconds May 01 12:58:42 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:42 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:58:42 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:42 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:42 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:42 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4259,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JASON DERULO & NUKA - LOVE NOT WAR (THE TAMPA BEAT)","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:42 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:42 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:42 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:42 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:42 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:42 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:58:42 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:42 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:42 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:42 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:58:42 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:58:42 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:58:42 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4259,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"JASON DERULO & NUKA - LOVE NOT WAR (THE TAMPA BEAT)","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} May 01 12:58:42 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:58:42 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:58:42 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:58:42 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:58:42 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:42 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:42 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:58:42 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:58:42 volumio volumio[1019]: info: ------------------------------ 62ms May 01 12:58:42 volumio volumio[1019]: info: ------------------------------ 59ms May 01 12:58:43 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:58:44 volumio volumio[1019]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 May 01 12:58:45 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:58:48 volumio volumio[1019]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 May 01 12:58:48 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:49 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:58:49 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:58:52 volumio volumio[1019]: info: Enabling MyMusic plugin bluetooth May 01 12:58:52 volumio volumio[1019]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth May 01 12:58:52 volumio volumio[1019]: info: [MyVolumio PluginManager] Plugin audio_interface bluetooth not in user plan, not enabling May 01 12:58:52 volumio volumio[1019]: info: Error: Plugin audio_interface bluetooth not in user plan, not enabling May 01 12:58:52 volumio volumio[1019]: error: Could not Enable MyMusic Plugin: Error May 01 12:58:53 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:58:53 volumio sudo[3688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 12:58:53 volumio sudo[3686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 12:58:53 volumio sudo[3686]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:58:53 volumio sudo[3688]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:58:54 volumio sudo[3686]: pam_unix(sudo:session): session closed for user root May 01 12:58:54 volumio sudo[3688]: pam_unix(sudo:session): session closed for user root May 01 12:58:54 volumio volumio[1019]: verbose: New Socket.io Connection to 192.168.3.37 from 192.168.3.5 UA: Mozilla/5.0 (Linux; Android 12; TNA-AN00 Build/HONORTNA-AN00; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/92.0.4515.105 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 01 12:58:54 volumio sudo[3694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 12:58:54 volumio sudo[3694]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:58:54 volumio sudo[3694]: pam_unix(sudo:session): session closed for user root May 01 12:58:54 volumio sudo[3697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 12:58:54 volumio sudo[3697]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:58:54 volumio sudo[3697]: pam_unix(sudo:session): session closed for user root May 01 12:58:54 volumio volumio[1019]: info: Received Get System Info May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 12:58:54 volumio volumio[1019]: info: Discovery: Getting this device information May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetVisibleSources May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 12:58:54 volumio volumio[1019]: info: Received Get System Info May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 12:58:54 volumio volumio[1019]: info: Discovery: Getting this device information May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:54 volumio volumio[1019]: info: Listing playlists May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetQueue May 01 12:58:54 volumio volumio[1019]: info: CoreStateMachine::getQueue May 01 12:58:54 volumio volumio[1019]: info: CorePlayQueue::getQueue May 01 12:58:54 volumio volumio[1019]: verbose: New Socket.io Connection to 192.168.3.37 from 192.168.3.5 UA: Mozilla/5.0 (Linux; Android 12; TNA-AN00 Build/HONORTNA-AN00; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/92.0.4515.105 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 01 12:58:54 volumio volumio[1019]: info: Received Get System Info May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 12:58:54 volumio volumio[1019]: info: Discovery: Getting this device information May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetVisibleSources May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 12:58:54 volumio volumio[1019]: info: Received Get System Info May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 12:58:54 volumio volumio[1019]: info: Discovery: Getting this device information May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:54 volumio volumio[1019]: info: Listing playlists May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::volumioGetQueue May 01 12:58:54 volumio volumio[1019]: info: CoreStateMachine::getQueue May 01 12:58:54 volumio volumio[1019]: info: CorePlayQueue::getQueue May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 01 12:58:54 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 01 12:58:55 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:58:57 volumio sudo[3705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 12:58:57 volumio sudo[3705]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:58:57 volumio sudo[3705]: pam_unix(sudo:session): session closed for user root May 01 12:58:57 volumio sudo[3707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 12:58:57 volumio sudo[3707]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:58:57 volumio sudo[3707]: pam_unix(sudo:session): session closed for user root May 01 12:58:57 volumio volumio[1019]: verbose: New Socket.io Connection to 192.168.3.37 from 192.168.3.5 UA: Mozilla/5.0 (Linux; Android 12; TNA-AN00 Build/HONORTNA-AN00; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/92.0.4515.105 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 01 12:58:57 volumio volumio[1019]: info: Received Get System Info May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 12:58:57 volumio volumio[1019]: info: Discovery: Getting this device information May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetVisibleSources May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 12:58:57 volumio volumio[1019]: info: Received Get System Info May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 12:58:57 volumio volumio[1019]: info: Discovery: Getting this device information May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:57 volumio volumio[1019]: info: Listing playlists May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetQueue May 01 12:58:57 volumio volumio[1019]: info: CoreStateMachine::getQueue May 01 12:58:57 volumio volumio[1019]: info: CorePlayQueue::getQueue May 01 12:58:57 volumio volumio[1019]: info: Received Get System Info May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 12:58:57 volumio volumio[1019]: info: Discovery: Getting this device information May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:58:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 01 12:58:58 volumio volumio[1019]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 01 12:58:58 volumio volumio[1019]: info: Retrying Login Due to Network Error May 01 12:59:01 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:59:02 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:59:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 12:59:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 12:59:06 volumio volumio[1019]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 May 01 12:59:06 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:59:07 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 12:59:07 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:59:08 volumio volumio[1019]: info: MyVolumio login type: Token May 01 12:59:09 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 12:59:09 volumio volumio[1019]: info: CURURI: music-library May 01 12:59:09 volumio volumio[1019]: info: Preload queue cleared May 01 12:59:10 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 12:59:10 volumio volumio[1019]: info: CURURI: music-library/USB May 01 12:59:10 volumio volumio[1019]: info: Preload queue cleared May 01 12:59:12 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 12:59:12 volumio volumio[1019]: info: CURURI: music-library/USB/大白菜U盘 May 01 12:59:12 volumio volumio[1019]: info: Preload queue cleared May 01 12:59:13 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:59:16 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 12:59:16 volumio volumio[1019]: info: CURURI: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz May 01 12:59:16 volumio volumio[1019]: info: Preload queue cleared May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/02.完成不了的爱.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/03.想念你.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/04.对你爱不完.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/05.别再说.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/06.无情伤.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/07.女人如烟.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/08.伤心的话留到明天在说.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/09.听到你一声再会.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/10.怎么说我不爱你.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/11.让我一次爱个够.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/12.春天里.wav May 01 12:59:16 volumio volumio[1019]: info: Preloading song: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/13.我们的歌谣.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F01.%E5%8F%A3%E6%98%AF%E5%BF%83%E9%9D%9E.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/02.完成不了的爱.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F02.%E5%AE%8C%E6%88%90%E4%B8%8D%E4%BA%86%E7%9A%84%E7%88%B1.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/02.完成不了的爱.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/03.想念你.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F03.%E6%83%B3%E5%BF%B5%E4%BD%A0.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/03.想念你.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/04.对你爱不完.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F04.%E5%AF%B9%E4%BD%A0%E7%88%B1%E4%B8%8D%E5%AE%8C.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/04.对你爱不完.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/05.别再说.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F05.%E5%88%AB%E5%86%8D%E8%AF%B4.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/05.别再说.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/06.无情伤.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F06.%E6%97%A0%E6%83%85%E4%BC%A4.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/06.无情伤.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/07.女人如烟.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F07.%E5%A5%B3%E4%BA%BA%E5%A6%82%E7%83%9F.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/07.女人如烟.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/08.伤心的话留到明天在说.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F08.%E4%BC%A4%E5%BF%83%E7%9A%84%E8%AF%9D%E7%95%99%E5%88%B0%E6%98%8E%E5%A4%A9%E5%9C%A8%E8%AF%B4.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/08.伤心的话留到明天在说.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/09.听到你一声再会.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F09.%E5%90%AC%E5%88%B0%E4%BD%A0%E4%B8%80%E5%A3%B0%E5%86%8D%E4%BC%9A.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/09.听到你一声再会.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/10.怎么说我不爱你.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F10.%E6%80%8E%E4%B9%88%E8%AF%B4%E6%88%91%E4%B8%8D%E7%88%B1%E4%BD%A0.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/10.怎么说我不爱你.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/11.让我一次爱个够.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F11.%E8%AE%A9%E6%88%91%E4%B8%80%E6%AC%A1%E7%88%B1%E4%B8%AA%E5%A4%9F.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/11.让我一次爱个够.wav May 01 12:59:16 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/12.春天里.wav in service mpd May 01 12:59:16 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F12.%E6%98%A5%E5%A4%A9%E9%87%8C.wav&metadata=false May 01 12:59:16 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/12.春天里.wav May 01 12:59:17 volumio volumio[1019]: info: Exploding uri music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/13.我们的歌谣.wav in service mpd May 01 12:59:17 volumio volumio[1019]: info: ALBUMART /albumart?cacheid=292&web=//extralarge&path=%2Fmnt%2FUSB%2F%E5%A4%A7%E7%99%BD%E8%8F%9CU%E7%9B%98%2F34%20%E5%BC%A0%E7%8E%AE%E4%BC%BD%20%20%E7%87%83%E7%83%A7%E5%AF%82%E8%8E%AB%20CD2%20WAV%20%20%2024bit%2096khz%2F13.%E6%88%91%E4%BB%AC%E7%9A%84%E6%AD%8C%E8%B0%A3.wav&metadata=false May 01 12:59:17 volumio volumio[1019]: info: URI /mnt/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/13.我们的歌谣.wav May 01 12:59:17 volumio volumio[1019]: info: Preload queue cleared May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::ClearQueue May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::stop May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::stPlaybackTimer May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::serviceStop May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::serviceStop May 01 12:59:17 volumio volumio[1019]: info: [1746075557759] ControllerWebradio::stop May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::clearPlayQueue May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::saveQueue May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::addQueueItems May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::addQueueItems May 01 12:59:17 volumio volumio[1019]: info: Preload queue cleared May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/02.完成不了的爱.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/02.完成不了的爱.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/03.想念你.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/03.想念你.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/04.对你爱不完.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/04.对你爱不完.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/05.别再说.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/05.别再说.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/06.无情伤.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/06.无情伤.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/07.女人如烟.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/07.女人如烟.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/08.伤心的话留到明天在说.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/08.伤心的话留到明天在说.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/09.听到你一声再会.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/09.听到你一声再会.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/10.怎么说我不爱你.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/10.怎么说我不爱你.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/11.让我一次爱个够.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/11.让我一次爱个够.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/12.春天里.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/12.春天里.wav May 01 12:59:17 volumio volumio[1019]: info: Adding Item to queue: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/13.我们的歌谣.wav May 01 12:59:17 volumio volumio[1019]: info: Using cached record of: music-library/USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/13.我们的歌谣.wav May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::saveQueue May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::play index 0 May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::stop May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::play index undefined May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::startPlaybackTimer May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::clearAddPlayTracks USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop May 01 12:59:17 volumio volumio[1019]: info: May 01 12:59:17 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:59:17 volumio volumio[1019]: info: sendMpdCommand stop took 78 milliseconds May 01 12:59:17 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:59:17 volumio volumio[1019]: info: sendMpdCommand stop took 35 milliseconds May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clear May 01 12:59:17 volumio volumio[1019]: info: May 01 12:59:17 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:59:17 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:59:17 volumio volumio[1019]: info: sendMpdCommand status took 3 milliseconds May 01 12:59:17 volumio volumio[1019]: info: sendMpdCommand clear took 4 milliseconds May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand add "USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav" May 01 12:59:17 volumio volumio[1019]: info: May 01 12:59:17 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:59:17 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:59:17 volumio volumio[1019]: error: updateQueue error: null May 01 12:59:17 volumio volumio[1019]: info: May 01 12:59:17 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:59:17 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:59:17 volumio volumio[1019]: info: ------------------------------ 49ms May 01 12:59:17 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 47 milliseconds May 01 12:59:17 volumio volumio[1019]: info: sendMpdCommand add "USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav" took 47 milliseconds May 01 12:59:17 volumio volumio[1019]: info: sendMpdCommand status took 43 milliseconds May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand play May 01 12:59:17 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:59:17 volumio volumio[1019]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 12:59:17 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:17 volumio volumio[1019]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 12:59:17 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::syncState stateService stop May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:59:17 volumio volumio[1019]: info: No code May 01 12:59:17 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:59:17 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:17 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:59:17 volumio volumio[1019]: info: ------------------------------ 88ms May 01 12:59:17 volumio volumio[1019]: info: ------------------------------ 128ms May 01 12:59:17 volumio volumio[1019]: info: May 01 12:59:17 volumio volumio[1019]: ---------------------------- MPD announces system playlist update May 01 12:59:17 volumio volumio[1019]: info: Ignoring MPD Status Update May 01 12:59:18 volumio volumio[1019]: info: May 01 12:59:18 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:59:18 volumio volumio[1019]: info: May 01 12:59:18 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:59:18 volumio volumio[1019]: info: ------------------------------ 123ms May 01 12:59:18 volumio volumio[1019]: info: sendMpdCommand play took 120 milliseconds May 01 12:59:18 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:59:18 volumio volumio[1019]: info: ------------------------------ 41ms May 01 12:59:18 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:59:18 volumio volumio[1019]: info: May 01 12:59:18 volumio volumio[1019]: ---------------------------- MPD announces state update: player May 01 12:59:18 volumio volumio[1019]: info: ControllerMpd::getState May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status May 01 12:59:18 volumio volumio[1019]: info: touch_display: Setting screensaver timeout to 120 seconds. May 01 12:59:18 volumio volumio[1019]: info: sendMpdCommand status took 49 milliseconds May 01 12:59:18 volumio volumio[1019]: info: sendMpdCommand status took 48 milliseconds May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::parseState May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:59:18 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 19 milliseconds May 01 12:59:18 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 16 milliseconds May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:59:18 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo May 01 12:59:18 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:59:18 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:59:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:18 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":304,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.口是心非.wav","artist":null,"album":null,"uri":"USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav","trackType":"wav"} May 01 12:59:18 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:59:18 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:59:18 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop May 01 12:59:18 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:59:18 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:59:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:18 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":304,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.口是心非.wav","artist":null,"album":null,"uri":"USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav","trackType":"wav"} May 01 12:59:18 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:59:18 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:59:18 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:59:18 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:59:18 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:59:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:18 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:59:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:59:18 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:59:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:59:18 volumio volumio[1019]: info: ControllerMpd::pushState May 01 12:59:18 volumio volumio[1019]: info: CoreCommandRouter::servicePushState May 01 12:59:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:18 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":304,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.口是心非.wav","artist":null,"album":null,"uri":"USB/大白菜U盘/34 张玮伽 燃烧寂莫 CD2 WAV 24bit 96khz/01.口是心非.wav","trackType":"wav"} May 01 12:59:18 volumio volumio[1019]: verbose: CURRENT POSITION 0 May 01 12:59:18 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play May 01 12:59:18 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play May 01 12:59:18 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload May 01 12:59:18 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:59:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:59:18 volumio volumio[1019]: info: CoreStateMachine::pushState May 01 12:59:18 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:18 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState May 01 12:59:18 volumio volumio[1019]: info: ------------------------------ 114ms May 01 12:59:18 volumio volumio[1019]: info: ------------------------------ 147ms May 01 12:59:18 volumio volumio[1019]: info: ------------------------------ 140ms May 01 12:59:18 volumio volumio[1019]: info: touch_display: Setting screensaver timeout to 0 seconds. May 01 12:59:19 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:59:19 volumio volumio[1019]: info: peppy_screensaver: Start PeppyMeter May 01 12:59:25 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:59:31 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:59:33 volumio volumio[1019]: info: Retrieving Cloud Streaming UI May 01 12:59:33 volumio volumio[1019]: info: Getting Tidal Cloud Configuration May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:59:33 volumio volumio[1019]: info: Getting Qobuz Cloud Configuration May 01 12:59:33 volumio volumio[1019]: info: Asking plugin for UI Config May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:59:33 volumio volumio[1019]: info: Getting Spotify Cloud Configuration May 01 12:59:33 volumio volumio[1019]: info: Asking plugin for UI Config May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:59:33 volumio volumio[1019]: info: Saving Spotify Acccount May 01 12:59:33 volumio volumio[1019]: info: Got Tidal Cloud Configuration May 01 12:59:33 volumio volumio[1019]: info: Got it May 01 12:59:33 volumio volumio[1019]: info: Got it May 01 12:59:33 volumio volumio[1019]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:59:33 volumio volumio[1019]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::volumioGetBrowseSources May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::volumioGetBrowseSources May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::volumioGetBrowseSources May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:59:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 01 12:59:34 volumio volumio[1019]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 May 01 12:59:37 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:59:37 volumio volumio[1019]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 May 01 12:59:37 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState May 01 12:59:37 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 May 01 12:59:37 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:59:38 volumio volumio[1019]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 01 12:59:38 volumio volumio[1019]: info: Retrying Login Due to Network Error May 01 12:59:41 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:59:43 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:59:45 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:59:48 volumio volumio[1019]: info: MyVolumio login type: Token May 01 12:59:49 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:59:49 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:59:53 volumio volumio[1019]: info: Enabling MyMusic plugin smart_inputs May 01 12:59:53 volumio volumio[1019]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service smart_inputs May 01 12:59:53 volumio volumio[1019]: info: [MyVolumio PluginManager] Plugin music_service smart_inputs not in user plan, not enabling May 01 12:59:53 volumio volumio[1019]: info: Error: Plugin music_service smart_inputs not in user plan, not enabling May 01 12:59:53 volumio volumio[1019]: error: Could not Enable MyMusic Plugin: Error May 01 12:59:53 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:59:55 volumio wpa_supplicant[859]: wlan0: Failed to initiate sched scan May 01 12:59:57 volumio volumio[1019]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 12:59:57 volumio volumio[1019]: Error: connect ETIMEDOUT 108.160.165.141:80 May 01 12:59:57 volumio volumio[1019]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 01 12:59:57 volumio volumio[1019]: errno: -110, May 01 12:59:57 volumio volumio[1019]: code: 'ETIMEDOUT', May 01 12:59:57 volumio volumio[1019]: syscall: 'connect', May 01 12:59:57 volumio volumio[1019]: address: '108.160.165.141', May 01 12:59:57 volumio volumio[1019]: port: 80 May 01 12:59:57 volumio volumio[1019]: } May 01 12:59:57 volumio volumio[1019]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 12:59:57 volumio sudo[4005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-01 12:58 May 01 12:59:57 volumio sudo[4005]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"