-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2025-11-01 17:27:41 UTC. -- Nov 01 17:26:01 volumio nmbd[618]: [2025/11/01 17:26:01.518515, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Nov 01 17:26:01 volumio nmbd[618]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.135 for name WORKGROUP<1d>. Nov 01 17:26:01 volumio nmbd[618]: This response was from IP 192.168.1.121, reporting an IP address of 192.168.1.121. Nov 01 17:26:04 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:26:06 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 17:26:06 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 17:26:06 volumio volumio[1087]: info: Discovery: Getting this device information Nov 01 17:26:06 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:06 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:06 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 17:26:06 volumio volumio[1087]: verbose: New Socket.io Connection to 192.168.1.135:3000 from 192.168.1.202 UA: Dart/3.5 (dart:io) Total Clients: 8 Nov 01 17:26:06 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:06 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:06 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 01 17:26:06 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 01 17:26:08 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:08 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:09 volumio volumio[1087]: verbose: New Socket.io Connection to 192.168.1.135:3000 from 192.168.1.202 UA: Dart/3.5 (dart:io) Total Clients: 9 Nov 01 17:26:09 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:09 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:09 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 01 17:26:09 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 01 17:26:09 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:09 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:09 volumio sudo[2048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 17:26:09 volumio sudo[2048]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:26:09 volumio sudo[2050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 17:26:09 volumio sudo[2050]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:26:09 volumio sudo[2048]: pam_unix(sudo:session): session closed for user root Nov 01 17:26:09 volumio sudo[2050]: pam_unix(sudo:session): session closed for user root Nov 01 17:26:10 volumio volumio[1087]: verbose: New Socket.io Connection to 192.168.1.135 from 192.168.1.202 UA: Mozilla/5.0 (Linux; Android 13; M2101K9G Build/TKQ1.220829.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Total Clients: 10 Nov 01 17:26:10 volumio sudo[2056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 17:26:10 volumio sudo[2056]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:26:10 volumio sudo[2056]: pam_unix(sudo:session): session closed for user root Nov 01 17:26:10 volumio sudo[2058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 17:26:10 volumio sudo[2058]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:26:10 volumio sudo[2058]: pam_unix(sudo:session): session closed for user root Nov 01 17:26:10 volumio volumio[1087]: verbose: New Socket.io Connection to 192.168.1.135 from 192.168.1.202 UA: Mozilla/5.0 (Linux; Android 13; M2101K9G Build/TKQ1.220829.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Total Clients: 11 Nov 01 17:26:11 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:11 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:11 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 17:26:11 volumio volumio[1087]: info: Listing playlists Nov 01 17:26:11 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 01 17:26:11 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 01 17:26:11 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 01 17:26:11 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 01 17:26:12 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:26:14 volumio volumio[1087]: info: CoreCommandRouter::volumioGetQueue Nov 01 17:26:14 volumio volumio[1087]: info: CoreStateMachine::getQueue Nov 01 17:26:14 volumio volumio[1087]: info: CorePlayQueue::getQueue Nov 01 17:26:14 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:14 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:14 volumio volumio[1087]: info: CoreCommandRouter::volumioPlay Nov 01 17:26:14 volumio volumio[1087]: verbose: UNSET VOLATILE Nov 01 17:26:14 volumio volumio[1087]: info: CoreStateMachine::play index undefined Nov 01 17:26:14 volumio volumio[1087]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:26:14 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:14 volumio volumio[1087]: info: CoreStateMachine::startPlaybackTimer Nov 01 17:26:14 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:14 volumio volumio[1087]: info: [1762017974091] ControllerUPNPBrowser::clearAddPlayTrack Nov 01 17:26:14 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 17:26:14 volumio volumio[1087]: info: sendMpdCommand stop took 2 milliseconds Nov 01 17:26:14 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 17:26:14 volumio volumio[1087]: info: Nov 01 17:26:14 volumio volumio[1087]: ---------------------------- MPD announces system playlist update Nov 01 17:26:14 volumio volumio[1087]: info: Ignoring MPD Status Update Nov 01 17:26:14 volumio volumio[1087]: info: sendMpdCommand clear took 4 milliseconds Nov 01 17:26:14 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.121:8200/MediaItems/111388.flac" Nov 01 17:26:14 volumio volumio[1087]: info: Nov 01 17:26:14 volumio volumio[1087]: ---------------------------- MPD announces system playlist update Nov 01 17:26:14 volumio volumio[1087]: info: Ignoring MPD Status Update Nov 01 17:26:14 volumio volumio[1087]: info: Nov 01 17:26:14 volumio volumio[1087]: ---------------------------- MPD announces system playlist update Nov 01 17:26:14 volumio volumio[1087]: info: Ignoring MPD Status Update Nov 01 17:26:14 volumio volumio[1087]: info: Nov 01 17:26:14 volumio volumio[1087]: ---------------------------- MPD announces system playlist update Nov 01 17:26:14 volumio volumio[1087]: info: Ignoring MPD Status Update Nov 01 17:26:14 volumio volumio[1087]: error: updateQueue error: null Nov 01 17:26:14 volumio volumio[1087]: info: ------------------------------ 14ms Nov 01 17:26:19 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:26:20 volumio volumio[1087]: error: updateQueue error: null Nov 01 17:26:20 volumio volumio[1087]: error: updateQueue error: null Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.121:8200/MediaItems/111388.flac" Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 6245ms Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 6243ms Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 6241ms Nov 01 17:26:20 volumio volumio[1087]: Upnp client error: Error: This socket has been ended by the other party Nov 01 17:26:20 volumio volumio[1087]: Upnp client error: Error: This socket has been ended by the other party Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces system playlist update Nov 01 17:26:20 volumio volumio[1087]: info: Ignoring MPD Status Update Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand add "http://192.168.1.121:8200/MediaItems/111388.flac" took 8 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand play Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces system playlist update Nov 01 17:26:20 volumio volumio[1087]: info: Ignoring MPD Status Update Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces system playlist update Nov 01 17:26:20 volumio volumio[1087]: info: Ignoring MPD Status Update Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces system playlist update Nov 01 17:26:20 volumio volumio[1087]: info: Ignoring MPD Status Update Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 14ms Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand play took 11 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 11ms Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 8ms Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 7ms Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand status took 31 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand status took 30 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand status took 28 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand status took 26 milliseconds Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand status took 14 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:20 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:20 volumio volumio[1087]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:20 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState stateService play Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus stop Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:20 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:20 volumio volumio[1087]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:20 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState stateService play Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:26:20 volumio volumio[1087]: info: Received an update from plugin. extracting info from payload Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:20 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:20 volumio volumio[1087]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:20 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState stateService play Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:26:20 volumio volumio[1087]: info: Received an update from plugin. extracting info from payload Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:20 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:20 volumio volumio[1087]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:20 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState stateService play Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:26:20 volumio volumio[1087]: info: Received an update from plugin. extracting info from payload Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 251ms Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 248ms Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 247ms Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 246ms Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:20 volumio volumio[1087]: info: Nov 01 17:26:20 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 217 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand status took 12 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand status took 9 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand status took 6 milliseconds Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:20 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:20 volumio volumio[1087]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:20 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState stateService play Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:26:20 volumio volumio[1087]: info: Received an update from plugin. extracting info from payload Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: ------------------------------ 349ms Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioGetQueue Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::getQueue Nov 01 17:26:20 volumio volumio[1087]: info: CorePlayQueue::getQueue Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 205 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 205 milliseconds Nov 01 17:26:20 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 204 milliseconds Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:20 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:20 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:20 volumio volumio[1087]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1600,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"618 Kbps","isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:20 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState stateService play Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:26:20 volumio volumio[1087]: info: Received an update from plugin. extracting info from payload Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:20 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:20 volumio volumio[1087]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1600,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"580 Kbps","isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:20 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState stateService play Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:26:20 volumio volumio[1087]: info: Received an update from plugin. extracting info from payload Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:20 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:20 volumio volumio[1087]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1600,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"580 Kbps","isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:20 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState stateService play Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:26:20 volumio volumio[1087]: info: Received an update from plugin. extracting info from payload Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:20 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:21 volumio volumio[1087]: info: ------------------------------ 451ms Nov 01 17:26:21 volumio volumio[1087]: info: ------------------------------ 448ms Nov 01 17:26:21 volumio volumio[1087]: info: ------------------------------ 446ms Nov 01 17:26:21 volumio volumio[1087]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::volumioPause Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::pause Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::stPlaybackTimer Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::servicePause Nov 01 17:26:26 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::servicePause Nov 01 17:26:26 volumio volumio[1087]: info: [1762017986258] ControllerUPNPBrowser::pause Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand pause Nov 01 17:26:26 volumio volumio[1087]: info: sendMpdCommand pause took 94 milliseconds Nov 01 17:26:26 volumio volumio[1087]: info: Nov 01 17:26:26 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:26 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:26 volumio volumio[1087]: info: Nov 01 17:26:26 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:26 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:26 volumio volumio[1087]: info: Nov 01 17:26:26 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:26 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:26 volumio volumio[1087]: info: Nov 01 17:26:26 volumio volumio[1087]: ---------------------------- MPD announces state update: player Nov 01 17:26:26 volumio volumio[1087]: info: ControllerMpd::getState Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:26:26 volumio volumio[1087]: info: sendMpdCommand status took 13 milliseconds Nov 01 17:26:26 volumio volumio[1087]: info: sendMpdCommand status took 10 milliseconds Nov 01 17:26:26 volumio volumio[1087]: info: sendMpdCommand status took 7 milliseconds Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:26 volumio volumio[1087]: info: sendMpdCommand status took 19 milliseconds Nov 01 17:26:26 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 14 milliseconds Nov 01 17:26:26 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 13 milliseconds Nov 01 17:26:26 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 12 milliseconds Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::parseState Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:26 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:26 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:26 volumio volumio[1087]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":7222,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"614 Kbps","isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:26 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::syncState stateService pause Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus pause Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::stPlaybackTimer Nov 01 17:26:26 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:26 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:26 volumio volumio[1087]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":7222,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"614 Kbps","isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:26 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::syncState stateService pause Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus pause Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::stPlaybackTimer Nov 01 17:26:26 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:26 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:26 volumio volumio[1087]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":7222,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"614 Kbps","isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:26 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::syncState stateService pause Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus pause Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::stPlaybackTimer Nov 01 17:26:26 volumio volumio[1087]: info: ------------------------------ 132ms Nov 01 17:26:26 volumio volumio[1087]: info: ------------------------------ 130ms Nov 01 17:26:26 volumio volumio[1087]: info: ------------------------------ 127ms Nov 01 17:26:26 volumio volumio[1087]: info: sendMpdCommand playlistinfo took 100 milliseconds Nov 01 17:26:26 volumio volumio[1087]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:26:26 volumio volumio[1087]: info: ControllerMpd::pushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::servicePushState Nov 01 17:26:26 volumio volumio[1087]: info: CorePlayQueue::getTrack 0 Nov 01 17:26:26 volumio volumio[1087]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":7222,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"614 Kbps","isStreaming":false,"title":"111388.flac","artist":null,"album":null,"uri":"http://192.168.1.121:8200/MediaItems/111388.flac","trackType":"flac"} Nov 01 17:26:26 volumio volumio[1087]: verbose: CURRENT POSITION 0 Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::syncState stateService pause Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::syncState currentStatus pause Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::pushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::volumioPushState Nov 01 17:26:26 volumio volumio[1087]: info: CoreStateMachine::stPlaybackTimer Nov 01 17:26:26 volumio volumio[1087]: info: ------------------------------ 181ms Nov 01 17:26:26 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Nov 01 17:26:26 volumio volumio[1087]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 01 17:26:26 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:26 volumio volumio[1087]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Nov 01 17:26:26 volumio volumio[1087]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 01 17:26:27 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:26:28 volumio volumio[1087]: info: CoreCommandRouter::volumioGetQueue Nov 01 17:26:28 volumio volumio[1087]: info: CoreStateMachine::getQueue Nov 01 17:26:28 volumio volumio[1087]: info: CorePlayQueue::getQueue Nov 01 17:26:29 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 01 17:26:29 volumio volumio[1087]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 01 17:26:29 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 01 17:26:29 volumio volumio[1087]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Nov 01 17:26:29 volumio volumio[1087]: info: Received Get System Version Nov 01 17:26:29 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 01 17:26:34 volumio volumio[1087]: info: CoreCommandRouter::volumioGetQueue Nov 01 17:26:34 volumio volumio[1087]: info: CoreStateMachine::getQueue Nov 01 17:26:34 volumio volumio[1087]: info: CorePlayQueue::getQueue Nov 01 17:26:34 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:34 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:26:35 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 17:26:35 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 17:26:35 volumio volumio[1087]: info: Discovery: Getting this device information Nov 01 17:26:35 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:35 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 17:26:42 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:26:42 volumio volumio[1087]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 17:26:42 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 17:26:50 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:26:51 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 01 17:26:54 volumio volumio[1087]: info: CoreCommandRouter::volumioGetQueue Nov 01 17:26:54 volumio volumio[1087]: info: CoreStateMachine::getQueue Nov 01 17:26:54 volumio volumio[1087]: info: CorePlayQueue::getQueue Nov 01 17:26:54 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:26:56 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 17:26:56 volumio volumio[1087]: info: CURURI: music-library Nov 01 17:26:57 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:27:04 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 17:27:04 volumio volumio[1087]: info: CURURI: music-library/USB Nov 01 17:27:05 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:27:05 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 17:27:05 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 17:27:05 volumio volumio[1087]: info: Discovery: Getting this device information Nov 01 17:27:05 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:27:05 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 17:27:06 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 17:27:06 volumio volumio[1087]: info: CURURI: music-library/USB/maxone Nov 01 17:27:09 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 17:27:09 volumio volumio[1087]: info: CURURI: music-library/USB/maxone/STRANIERI Nov 01 17:27:12 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:27:14 volumio volumio[1087]: info: CoreCommandRouter::volumioGetQueue Nov 01 17:27:14 volumio volumio[1087]: info: CoreStateMachine::getQueue Nov 01 17:27:14 volumio volumio[1087]: info: CorePlayQueue::getQueue Nov 01 17:27:14 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:27:20 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:27:27 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:27:31 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 01 17:27:34 volumio volumio[1087]: info: CoreCommandRouter::volumioGetQueue Nov 01 17:27:34 volumio volumio[1087]: info: CoreStateMachine::getQueue Nov 01 17:27:34 volumio volumio[1087]: info: CorePlayQueue::getQueue Nov 01 17:27:34 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:27:35 volumio wpa_supplicant[881]: wlan0: Failed to initiate sched scan Nov 01 17:27:35 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 17:27:35 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 17:27:35 volumio volumio[1087]: info: Discovery: Getting this device information Nov 01 17:27:35 volumio volumio[1087]: info: CoreCommandRouter::volumioGetState Nov 01 17:27:35 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 17:27:36 volumio volumio[1087]: info: Retrieving Cloud Streaming UI Nov 01 17:27:36 volumio volumio[1087]: info: Getting Tidal Cloud Configuration Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 17:27:36 volumio volumio[1087]: info: Getting Qobuz Cloud Configuration Nov 01 17:27:36 volumio volumio[1087]: info: Asking plugin for UI Config Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 17:27:36 volumio volumio[1087]: info: Getting Spotify Cloud Configuration Nov 01 17:27:36 volumio volumio[1087]: info: Asking plugin for UI Config Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 17:27:36 volumio volumio[1087]: info: Saving Spotify Acccount Nov 01 17:27:36 volumio volumio[1087]: info: Got Tidal Cloud Configuration Nov 01 17:27:36 volumio volumio[1087]: info: Got it Nov 01 17:27:36 volumio volumio[1087]: info: Got it Nov 01 17:27:36 volumio volumio[1087]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 17:27:36 volumio volumio[1087]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 17:27:36 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 01 17:27:37 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 01 17:27:37 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 01 17:27:40 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 01 17:27:40 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 01 17:27:40 volumio volumio[1087]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 17:27:40 volumio volumio[1087]: Error: getaddrinfo -3007 Nov 01 17:27:40 volumio volumio[1087]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Nov 01 17:27:40 volumio volumio[1087]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Nov 01 17:27:40 volumio volumio[1087]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Nov 01 17:27:40 volumio volumio[1087]: code: -3007, Nov 01 17:27:40 volumio volumio[1087]: errno: -3007, Nov 01 17:27:40 volumio volumio[1087]: syscall: 'getaddrinfo' Nov 01 17:27:40 volumio volumio[1087]: } Nov 01 17:27:40 volumio volumio[1087]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 17:27:41 volumio sudo[2176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-01 17:26 Nov 01 17:27:41 volumio sudo[2176]: 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="3cfa1502993c2310fc263d6ebda1707071fe4cc2" VOLUMIO_FE_VERSION="8efe4f08f83e5de574651b8ed2333629c140d365" VOLUMIO_FE3_VERSION="8f1d07fcde806ea34f52cff908ec76359e14970e" VOLUMIO_BE_VERSION="e249dfa388452e6b8443121dc9b4cabca459c531" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 09 Jun 2022 05:55:51 PM CEST" VOLUMIO_VERSION="3.301" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6a8974e587cd4bab189d231f79b65462"