-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Wed 2024-04-03 13:35:28 UTC. -- Apr 03 13:34:00 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 03 13:34:01 volumio volumio[876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%A7%9C%E8%82%B2%E6%81%92/%E5%88%AB%E8%AE%A9%E6%88%91%E4%B8%80%E4%B8%AA%E4%BA%BA%E9%86%89/fda260f6-c10d-40f5-806b-e2cc7f546668.jpg' Apr 03 13:34:02 volumio volumio[876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eddie%20Hinton/Very%20Blue%20Highway/0bd91769-455a-46e6-b78e-7dc0fee1c3bd.jpg' Apr 03 13:34:02 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 03 13:34:03 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:34:03 volumio volumio[876]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 13:34:03 volumio volumio[876]: info: CoreStateMachine::ClearQueue Apr 03 13:34:03 volumio volumio[876]: info: CoreStateMachine::stop Apr 03 13:34:03 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:03 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:34:03 volumio volumio[876]: info: CorePlayQueue::clearPlayQueue Apr 03 13:34:03 volumio volumio[876]: info: CorePlayQueue::saveQueue Apr 03 13:34:03 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:34:03 volumio volumio[876]: info: CoreCommandRouter::volumioPushQueue Apr 03 13:34:03 volumio volumio[876]: info: CoreStateMachine::addQueueItems Apr 03 13:34:03 volumio volumio[876]: info: CorePlayQueue::addQueueItems Apr 03 13:34:03 volumio volumio[876]: info: Adding Item to queue: upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5376 Apr 03 13:34:03 volumio volumio[876]: info: Exploding uri upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5376 in service upnp_browser Apr 03 13:34:04 volumio volumio[876]: info: CorePlayQueue::saveQueue Apr 03 13:34:04 volumio volumio[876]: info: CoreCommandRouter::volumioPushQueue Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::updateTrackBlock Apr 03 13:34:04 volumio volumio[876]: info: CorePlayQueue::getTrackBlock Apr 03 13:34:04 volumio volumio[876]: info: CoreCommandRouter::volumioPlay Apr 03 13:34:04 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::play index 0 Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::stop Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:04 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::play index undefined Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:04 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::startPlaybackTimer Apr 03 13:34:04 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:34:04 volumio volumio[876]: info: [1712151244067] ControllerUPNPBrowser::clearAddPlayTrack Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 13:34:04 volumio volumio[876]: info: Apr 03 13:34:04 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand stop took 8 milliseconds Apr 03 13:34:04 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 13:34:04 volumio volumio[876]: info: Apr 03 13:34:04 volumio volumio[876]: ---------------------------- MPD announces system playlist update Apr 03 13:34:04 volumio volumio[876]: info: Ignoring MPD Status Update Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand status took 7 milliseconds Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand clear took 6 milliseconds Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.50.76:50002/m/MP3/46318.mp3" Apr 03 13:34:04 volumio volumio[876]: error: updateQueue error: null Apr 03 13:34:04 volumio volumio[876]: info: ------------------------------ 8ms Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:34:04 volumio volumio[876]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 03 13:34:04 volumio volumio[876]: info: ------------------------------ 18ms Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.50.76:50002/m/MP3/46318.mp3" Apr 03 13:34:04 volumio volumio[876]: info: Apr 03 13:34:04 volumio volumio[876]: ---------------------------- MPD announces system playlist update Apr 03 13:34:04 volumio volumio[876]: info: Ignoring MPD Status Update Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand add "http://192.168.50.76:50002/m/MP3/46318.mp3" took 7 milliseconds Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand play Apr 03 13:34:04 volumio volumio[876]: info: ------------------------------ 7ms Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand play took 4 milliseconds Apr 03 13:34:04 volumio volumio[876]: info: Apr 03 13:34:04 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:34:04 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:34:04 volumio volumio[876]: info: Apr 03 13:34:04 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:34:04 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand status took 26 milliseconds Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand status took 65 milliseconds Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand clearerror took 59 milliseconds Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand playlistinfo took 49 milliseconds Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:34:04 volumio volumio[876]: info: ControllerMpd::pushState Apr 03 13:34:04 volumio volumio[876]: info: CoreCommandRouter::servicePushState Apr 03 13:34:04 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:34:04 volumio volumio[876]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"46318.mp3","artist":null,"album":null,"uri":"http://192.168.50.76:50002/m/MP3/46318.mp3","trackType":"mp3"} Apr 03 13:34:04 volumio volumio[876]: verbose: CURRENT POSITION 0 Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::syncState stateService pause Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus stop Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:34:04 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 13:34:04 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:34:04 volumio volumio[876]: info: ------------------------------ 244ms Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand clearerror took 191 milliseconds Apr 03 13:34:04 volumio volumio[876]: info: sendMpdCommand playlistinfo took 177 milliseconds Apr 03 13:34:04 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:34:04 volumio volumio[876]: info: ControllerMpd::pushState Apr 03 13:34:04 volumio volumio[876]: info: CoreCommandRouter::servicePushState Apr 03 13:34:04 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:34:04 volumio volumio[876]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":173,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"46318.mp3","artist":null,"album":null,"uri":"http://192.168.50.76:50002/m/MP3/46318.mp3","trackType":"mp3"} Apr 03 13:34:04 volumio volumio[876]: verbose: CURRENT POSITION 0 Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::syncState stateService pause Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus stop Apr 03 13:34:04 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:34:04 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 13:34:04 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:34:04 volumio volumio[876]: info: ------------------------------ 306ms Apr 03 13:34:08 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:34:09 volumio kernel: rpi_firmware_get_throttled: 2 callbacks suppressed Apr 03 13:34:09 volumio kernel: Under-voltage detected! (0x00050005) Apr 03 13:34:13 volumio volumio[876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Weepies/Say%20I%20Am%20You/92a8e2d5-09a0-4b17-837e-59589266fabd.png' Apr 03 13:34:13 volumio volumio[876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Westlife/Westlife/25cae018-379f-4fa9-818f-df4dc04628f3.png' Apr 03 13:34:13 volumio kernel: Voltage normalised (0x00000000) Apr 03 13:34:13 volumio volumio[876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/MARIAH%20CAREY/MARIAH%20CAREY/f60973fc-8c2f-44a5-96ee-7ce6152dcd82.png' Apr 03 13:34:14 volumio volumio[876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/BBMak/Sooner%20or%20Later/ca862486-32f5-466e-82d0-b09716a42476.jpg' Apr 03 13:34:14 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:34:15 volumio volumio[876]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 13:34:15 volumio volumio[876]: info: CoreStateMachine::ClearQueue Apr 03 13:34:15 volumio volumio[876]: info: CoreStateMachine::stop Apr 03 13:34:15 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:15 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:34:15 volumio volumio[876]: info: CorePlayQueue::clearPlayQueue Apr 03 13:34:15 volumio volumio[876]: info: CorePlayQueue::saveQueue Apr 03 13:34:15 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:34:15 volumio volumio[876]: info: CoreCommandRouter::volumioPushQueue Apr 03 13:34:15 volumio volumio[876]: info: CoreStateMachine::addQueueItems Apr 03 13:34:15 volumio volumio[876]: info: CorePlayQueue::addQueueItems Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$4131 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$4131 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$4113 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$4113 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5299 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5299 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5396 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5396 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5298 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5298 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$4112 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$4112 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5296 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5296 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5297 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/folder/http://192.168.50.76:50001/ContentDirectory/control@22$5297 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@31447 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@31447 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@31466 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@31466 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@44930 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@44930 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@44921 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@44921 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@46944 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@46944 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@50794 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@50794 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@50793 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@50793 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@44920 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@44920 in service upnp_browser Apr 03 13:34:15 volumio volumio[876]: info: Adding Item to queue: upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@46943 Apr 03 13:34:15 volumio volumio[876]: info: Exploding uri upnp/http://192.168.50.76:50001/ContentDirectory/control@22$@46943 in service upnp_browser Apr 03 13:34:16 volumio volumio[876]: info: CorePlayQueue::saveQueue Apr 03 13:34:16 volumio volumio[876]: info: CoreCommandRouter::volumioPushQueue Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::updateTrackBlock Apr 03 13:34:16 volumio volumio[876]: info: CorePlayQueue::getTrackBlock Apr 03 13:34:16 volumio volumio[876]: info: CoreCommandRouter::volumioPlay Apr 03 13:34:16 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::play index 10 Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::stop Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:16 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::play index undefined Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:16 volumio volumio[876]: info: CorePlayQueue::getTrack 10 Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::startPlaybackTimer Apr 03 13:34:16 volumio volumio[876]: info: CorePlayQueue::getTrack 10 Apr 03 13:34:16 volumio volumio[876]: info: [1712151256235] ControllerUPNPBrowser::clearAddPlayTrack Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 13:34:16 volumio volumio[876]: info: Apr 03 13:34:16 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand stop took 8 milliseconds Apr 03 13:34:16 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 13:34:16 volumio volumio[876]: info: Apr 03 13:34:16 volumio volumio[876]: ---------------------------- MPD announces system playlist update Apr 03 13:34:16 volumio volumio[876]: info: Ignoring MPD Status Update Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand status took 5 milliseconds Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand clear took 5 milliseconds Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.50.76:50002/m/MP3/45906.mp3" Apr 03 13:34:16 volumio volumio[876]: error: updateQueue error: null Apr 03 13:34:16 volumio volumio[876]: info: ------------------------------ 7ms Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:34:16 volumio volumio[876]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 03 13:34:16 volumio volumio[876]: info: ------------------------------ 16ms Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.50.76:50002/m/MP3/45906.mp3" Apr 03 13:34:16 volumio volumio[876]: info: Apr 03 13:34:16 volumio volumio[876]: ---------------------------- MPD announces system playlist update Apr 03 13:34:16 volumio volumio[876]: info: Ignoring MPD Status Update Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand add "http://192.168.50.76:50002/m/MP3/45906.mp3" took 3 milliseconds Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand play Apr 03 13:34:16 volumio volumio[876]: info: ------------------------------ 4ms Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand play took 4 milliseconds Apr 03 13:34:16 volumio volumio[876]: info: Apr 03 13:34:16 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:34:16 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:34:16 volumio volumio[876]: info: Apr 03 13:34:16 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:34:16 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand status took 17 milliseconds Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand status took 26 milliseconds Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand clearerror took 11 milliseconds Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:34:16 volumio volumio[876]: info: ControllerMpd::pushState Apr 03 13:34:16 volumio volumio[876]: info: CoreCommandRouter::servicePushState Apr 03 13:34:16 volumio volumio[876]: info: CorePlayQueue::getTrack 10 Apr 03 13:34:16 volumio volumio[876]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"45906.mp3","artist":null,"album":null,"uri":"http://192.168.50.76:50002/m/MP3/45906.mp3","trackType":"mp3"} Apr 03 13:34:16 volumio volumio[876]: verbose: CURRENT POSITION 10 Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::syncState stateService pause Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus stop Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:34:16 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 13:34:16 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:34:16 volumio volumio[876]: info: ------------------------------ 50ms Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand clearerror took 27 milliseconds Apr 03 13:34:16 volumio volumio[876]: info: sendMpdCommand playlistinfo took 25 milliseconds Apr 03 13:34:16 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:34:16 volumio volumio[876]: info: ControllerMpd::pushState Apr 03 13:34:16 volumio volumio[876]: info: CoreCommandRouter::servicePushState Apr 03 13:34:16 volumio volumio[876]: info: CorePlayQueue::getTrack 10 Apr 03 13:34:16 volumio volumio[876]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"45906.mp3","artist":null,"album":null,"uri":"http://192.168.50.76:50002/m/MP3/45906.mp3","trackType":"mp3"} Apr 03 13:34:16 volumio volumio[876]: verbose: CURRENT POSITION 10 Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::syncState stateService pause Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus stop Apr 03 13:34:16 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:34:16 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:34:16 volumio volumio[876]: info: ------------------------------ 72ms Apr 03 13:34:17 volumio volumio[876]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 03 13:34:17 volumio volumio[876]: info: Retrying Login Due to Network Error Apr 03 13:34:19 volumio ntpd[656]: 193.182.111.143 local addr 192.168.50.55 -> Apr 03 13:34:19 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:34:20 volumio kernel: Under-voltage detected! (0x00050005) Apr 03 13:34:21 volumio volumio[876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Brett%20Anderson/Brett%20Anderson/6bc53647-130e-4194-bef8-8e561d421791.jpg' Apr 03 13:34:25 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:34:26 volumio kernel: Voltage normalised (0x00000000) Apr 03 13:34:27 volumio volumio[876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Weepies/Happiness/9c021070-456b-429b-b26c-cedb0301957d.png' Apr 03 13:34:27 volumio volumio[876]: info: MyVolumio login type: Token Apr 03 13:34:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 03 13:34:29 volumio volumio[876]: info: CURURI: music-library Apr 03 13:34:30 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 03 13:34:30 volumio volumio[876]: info: CURURI: music-library/USB Apr 03 13:34:30 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 03 13:34:30 volumio volumio[876]: info: CURURI: music-library/USB/HIKSEMI Apr 03 13:34:30 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:34:31 volumio volumio[876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Babyface/A%20Love%20Story/ec88e93e-2bed-4fed-bc18-45667c47c52a.jpg' Apr 03 13:34:33 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 03 13:34:33 volumio volumio[876]: info: CURURI: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选 Apr 03 13:34:34 volumio volumio[876]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::ClearQueue Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::stop Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:34 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::clearPlayQueue Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::saveQueue Apr 03 13:34:34 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:34:34 volumio volumio[876]: info: CoreCommandRouter::volumioPushQueue Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::addQueueItems Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::addQueueItems Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/02.Blueberry Hill.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/02.Blueberry Hill.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/03.You're Mine You.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/03.You're Mine You.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/04.Another Place Another Time.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/04.Another Place Another Time.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/05.Close to You.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/05.Close to You.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/06.What's A Wonderful World.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/06.What's A Wonderful World.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/07.Oncle Archibald.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/07.Oncle Archibald.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/08.Softly And Tenderly.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/08.Softly And Tenderly.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/09.Little White Lies.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/09.Little White Lies.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/10.Just A Closer Walk With Thee.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/10.Just A Closer Walk With Thee.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/11.Why Should I Care.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/11.Why Should I Care.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/12.Broken Vow.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/12.Broken Vow.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/13.L'enfant au Tambour.wav Apr 03 13:34:34 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/13.L'enfant au Tambour.wav in service mpd Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F01.When%20I%20Fall%20in%20Love.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F02.Blueberry%20Hill.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/02.Blueberry Hill.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F03.You're%20Mine%20You.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/03.You're Mine You.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F04.Another%20Place%20Another%20Time.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/04.Another Place Another Time.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F05.Close%20to%20You.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/05.Close to You.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F06.What's%20A%20Wonderful%20World.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/06.What's A Wonderful World.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F07.Oncle%20Archibald.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/07.Oncle Archibald.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F08.Softly%20And%20Tenderly.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/08.Softly And Tenderly.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F09.Little%20White%20Lies.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/09.Little White Lies.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F10.Just%20A%20Closer%20Walk%20With%20Thee.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/10.Just A Closer Walk With Thee.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F11.Why%20Should%20I%20Care.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/11.Why Should I Care.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F12.Broken%20Vow.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/12.Broken Vow.wav Apr 03 13:34:34 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F13.L'enfant%20au%20Tambour.wav&metadata=false Apr 03 13:34:34 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/13.L'enfant au Tambour.wav Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::saveQueue Apr 03 13:34:34 volumio volumio[876]: info: CoreCommandRouter::volumioPushQueue Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::updateTrackBlock Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::getTrackBlock Apr 03 13:34:34 volumio volumio[876]: info: CoreCommandRouter::volumioPlay Apr 03 13:34:34 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::play index 0 Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::stop Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:34 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::play index undefined Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::startPlaybackTimer Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::clearAddPlayTracks USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 13:34:34 volumio volumio[876]: info: Apr 03 13:34:34 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand stop took 7 milliseconds Apr 03 13:34:34 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 13:34:34 volumio volumio[876]: info: Apr 03 13:34:34 volumio volumio[876]: ---------------------------- MPD announces system playlist update Apr 03 13:34:34 volumio volumio[876]: info: Ignoring MPD Status Update Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand status took 6 milliseconds Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand clear took 6 milliseconds Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand add "USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav" Apr 03 13:34:34 volumio volumio[876]: error: updateQueue error: null Apr 03 13:34:34 volumio volumio[876]: info: Apr 03 13:34:34 volumio volumio[876]: ---------------------------- MPD announces system playlist update Apr 03 13:34:34 volumio volumio[876]: info: Ignoring MPD Status Update Apr 03 13:34:34 volumio volumio[876]: info: ------------------------------ 9ms Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand add "USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav" took 5 milliseconds Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand play Apr 03 13:34:34 volumio volumio[876]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 03 13:34:34 volumio volumio[876]: info: ------------------------------ 22ms Apr 03 13:34:34 volumio volumio[876]: info: ------------------------------ 12ms Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand play took 9 milliseconds Apr 03 13:34:34 volumio volumio[876]: info: Apr 03 13:34:34 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:34:34 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:34:34 volumio volumio[876]: info: Apr 03 13:34:34 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:34:34 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand status took 13 milliseconds Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand status took 20 milliseconds Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand clearerror took 12 milliseconds Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:34:34 volumio volumio[876]: info: ControllerMpd::pushState Apr 03 13:34:34 volumio volumio[876]: info: CoreCommandRouter::servicePushState Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:34:34 volumio volumio[876]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.When I Fall in Love.wav","artist":null,"album":null,"uri":"USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav","trackType":"wav"} Apr 03 13:34:34 volumio volumio[876]: verbose: CURRENT POSITION 0 Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::syncState stateService pause Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus stop Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:34:34 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 13:34:34 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:34:34 volumio volumio[876]: info: ------------------------------ 55ms Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand clearerror took 34 milliseconds Apr 03 13:34:34 volumio volumio[876]: info: sendMpdCommand playlistinfo took 30 milliseconds Apr 03 13:34:34 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:34:34 volumio volumio[876]: info: ControllerMpd::pushState Apr 03 13:34:34 volumio volumio[876]: info: CoreCommandRouter::servicePushState Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:34:34 volumio volumio[876]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.When I Fall in Love.wav","artist":null,"album":null,"uri":"USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav","trackType":"wav"} Apr 03 13:34:34 volumio volumio[876]: verbose: CURRENT POSITION 0 Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::syncState stateService pause Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus stop Apr 03 13:34:34 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:34:34 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:34:34 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:34:34 volumio volumio[876]: info: ------------------------------ 74ms Apr 03 13:34:36 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:34:39 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 13:34:40 volumio volumio[876]: info: Retrieving Cloud Streaming UI Apr 03 13:34:40 volumio volumio[876]: info: Getting Tidal Cloud Configuration Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 13:34:40 volumio volumio[876]: info: Getting Qobuz Cloud Configuration Apr 03 13:34:40 volumio volumio[876]: info: Asking plugin for UI Config Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 13:34:40 volumio volumio[876]: info: Getting Spotify Cloud Configuration Apr 03 13:34:40 volumio volumio[876]: info: Asking plugin for UI Config Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 13:34:40 volumio volumio[876]: info: Saving Spotify Acccount Apr 03 13:34:40 volumio volumio[876]: info: Got Tidal Cloud Configuration Apr 03 13:34:40 volumio volumio[876]: info: Got it Apr 03 13:34:40 volumio volumio[876]: info: Got it Apr 03 13:34:40 volumio volumio[876]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 13:34:40 volumio volumio[876]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::volumioGetBrowseSources Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 03 13:34:40 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 03 13:34:41 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:34:42 volumio ntpd[656]: 108.59.2.24 local addr 192.168.50.55 -> Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 03 13:34:44 volumio volumio[876]: Invalid card number. Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 03 13:34:44 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 03 13:34:46 volumio ntpd[656]: 193.182.111.12 local addr 192.168.50.55 -> Apr 03 13:34:47 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:34:49 volumio kernel: Under-voltage detected! (0x00050005) Apr 03 13:34:51 volumio nmbd[628]: [2024/04/03 13:34:51.749430, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 03 13:34:51 volumio nmbd[628]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.50.55 for name WORKGROUP<1d>. Apr 03 13:34:51 volumio nmbd[628]: This response was from IP 192.168.50.134, reporting an IP address of 192.168.254.1. Apr 03 13:34:53 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:34:57 volumio volumio[876]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 03 13:34:57 volumio volumio[876]: info: Retrying Login Due to Network Error Apr 03 13:34:58 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:35:04 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:35:05 volumio kernel: usb 1-1.3: new full-speed USB device number 5 using dwc_otg Apr 03 13:35:05 volumio kernel: usb 1-1.3: New USB device found, idVendor=08bb, idProduct=27c4, bcdDevice= 1.00 Apr 03 13:35:05 volumio kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Apr 03 13:35:05 volumio kernel: usb 1-1.3: Product: USB AUDIO DAC Apr 03 13:35:05 volumio kernel: usb 1-1.3: Manufacturer: BurrBrown from Texas Instruments Apr 03 13:35:05 volumio kernel: hid-generic 0003:08BB:27C4.0001: hidraw0: USB HID v1.00 Device [BurrBrown from Texas Instruments USB AUDIO DAC] on usb-3f980000.usb-1.3/input2 Apr 03 13:35:05 volumio kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored Apr 03 13:35:05 volumio kernel: usbcore: registered new interface driver snd-usb-audio Apr 03 13:35:05 volumio volumio[876]: info: Apr 03 13:35:05 volumio volumio[876]: ---------------------------- USB Audio Device Attached Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::Close All Modals sent Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 03 13:35:05 volumio volumio[876]: info: Setting mixer PCM for card USB AUDIO DAC Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 03 13:35:05 volumio volumio[876]: info: Updating Volume Controller Parameters: Device: 5 Name: USB AUDIO DAC Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 13:35:05 volumio volumio[876]: info: Preparing to generate the ALSA configuration file Apr 03 13:35:05 volumio volumio[876]: info: Asound.conf file unchanged, so no further update is needed Apr 03 13:35:05 volumio volumio[876]: info: Output device has changed, restarting MPD Apr 03 13:35:05 volumio sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 03 13:35:05 volumio volumio[876]: info: Output device has changed, restarting Shairport Sync Apr 03 13:35:05 volumio sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 13:35:05 volumio sudo[1385]: pam_unix(sudo:session): session closed for user root Apr 03 13:35:05 volumio sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 03 13:35:05 volumio sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:35:05 volumio systemd[1]: Stopping Music Player Daemon... Apr 03 13:35:05 volumio volumio[876]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 03 13:35:05 volumio systemd[1]: mpd.service: Succeeded. Apr 03 13:35:05 volumio systemd[1]: Stopped Music Player Daemon. Apr 03 13:35:05 volumio systemd[1]: Starting Music Player Daemon... Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 03 13:35:05 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 03 13:35:05 volumio volumio[876]: info: MPD Permissions set Apr 03 13:35:06 volumio volumio[876]: info: VolumeController:: Volume=0 Mute =false Apr 03 13:35:06 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:35:06 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 13:35:06 volumio volumio[876]: info: Starting Shairport Sync Apr 03 13:35:06 volumio sudo[1404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 03 13:35:06 volumio sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 03 13:35:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 03 13:35:06 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 03 13:35:06 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 03 13:35:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 03 13:35:06 volumio sudo[1404]: pam_unix(sudo:session): session closed for user root Apr 03 13:35:06 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 03 13:35:06 volumio volumio[876]: info: Shairport-Sync Started Apr 03 13:35:07 volumio mpd[1406]: Apr 03 13:35 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 03 13:35:07 volumio mpd[1406]: Apr 03 13:35 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 03 13:35:07 volumio mpd[1406]: Apr 03 13:35 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 03 13:35:07 volumio systemd[1]: Started Music Player Daemon. Apr 03 13:35:07 volumio sudo[1387]: pam_unix(sudo:session): session closed for user root Apr 03 13:35:07 volumio volumio[876]: error: updateQueue error: null Apr 03 13:35:07 volumio volumio[876]: info: MyVolumio login type: Token Apr 03 13:35:08 volumio volumio[876]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 03 13:35:08 volumio volumio[876]: info: CoreStateMachine::getcurrentVolume Apr 03 13:35:08 volumio volumio[876]: info: CoreCommandRouter::volumioRetrievevolume Apr 03 13:35:08 volumio volumio[876]: info: VolumeController:: Volume=0 Mute =false Apr 03 13:35:08 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:35:08 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:35:08 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 13:35:08 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:35:08 volumio volumio[876]: info: CoreStateMachine::updateTrackBlock Apr 03 13:35:08 volumio volumio[876]: info: CorePlayQueue::getTrackBlock Apr 03 13:35:08 volumio volumio[876]: info: CoreCommandRouter::volumioRetrievevolume Apr 03 13:35:08 volumio volumio[876]: info: VolumeController:: Volume=0 Mute =false Apr 03 13:35:08 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:35:08 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:35:08 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:35:09 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:35:15 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::ClearQueue Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::stop Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:35:19 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::clearPlayQueue Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::saveQueue Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::volumioPushQueue Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::addQueueItems Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::addQueueItems Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/02.Blueberry Hill.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/02.Blueberry Hill.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/03.You're Mine You.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/03.You're Mine You.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/04.Another Place Another Time.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/04.Another Place Another Time.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/05.Close to You.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/05.Close to You.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/06.What's A Wonderful World.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/06.What's A Wonderful World.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/07.Oncle Archibald.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/07.Oncle Archibald.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/08.Softly And Tenderly.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/08.Softly And Tenderly.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/09.Little White Lies.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/09.Little White Lies.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/10.Just A Closer Walk With Thee.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/10.Just A Closer Walk With Thee.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/11.Why Should I Care.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/11.Why Should I Care.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/12.Broken Vow.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/12.Broken Vow.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: Adding Item to queue: music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/13.L'enfant au Tambour.wav Apr 03 13:35:19 volumio volumio[876]: info: Exploding uri music-library/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/13.L'enfant au Tambour.wav in service mpd Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F01.When%20I%20Fall%20in%20Love.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F02.Blueberry%20Hill.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/02.Blueberry Hill.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F03.You're%20Mine%20You.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/03.You're Mine You.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F04.Another%20Place%20Another%20Time.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/04.Another Place Another Time.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F05.Close%20to%20You.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/05.Close to You.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F06.What's%20A%20Wonderful%20World.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/06.What's A Wonderful World.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F07.Oncle%20Archibald.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/07.Oncle Archibald.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F08.Softly%20And%20Tenderly.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/08.Softly And Tenderly.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F09.Little%20White%20Lies.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/09.Little White Lies.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F10.Just%20A%20Closer%20Walk%20With%20Thee.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/10.Just A Closer Walk With Thee.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F11.Why%20Should%20I%20Care.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/11.Why Should I Care.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F12.Broken%20Vow.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/12.Broken Vow.wav Apr 03 13:35:19 volumio volumio[876]: info: ALBUMART /albumart?cacheid=110&web=//extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2FA067.%E3%80%8A%E7%9C%9F%E7%A9%BA%E7%AE%A1%E5%BD%95%E9%9F%B330%E5%B9%B4%E3%80%8B%E6%9E%81%E5%93%81%E4%BA%BA%E5%A3%B0%E7%B2%BE%E9%80%89%2F13.L'enfant%20au%20Tambour.wav&metadata=false Apr 03 13:35:19 volumio volumio[876]: info: URI /mnt/USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/13.L'enfant au Tambour.wav Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::saveQueue Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::volumioPushQueue Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::updateTrackBlock Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::getTrackBlock Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::volumioPlay Apr 03 13:35:19 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::play index 0 Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::stop Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:35:19 volumio volumio[876]: verbose: UNSET VOLATILE Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::play index undefined Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::startPlaybackTimer Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::clearAddPlayTracks USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 13:35:19 volumio volumio[876]: info: sendMpdCommand stop took 3 milliseconds Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 13:35:19 volumio volumio[876]: info: Apr 03 13:35:19 volumio volumio[876]: ---------------------------- MPD announces system playlist update Apr 03 13:35:19 volumio volumio[876]: info: Ignoring MPD Status Update Apr 03 13:35:19 volumio volumio[876]: info: sendMpdCommand clear took 7 milliseconds Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand add "USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav" Apr 03 13:35:19 volumio volumio[876]: error: updateQueue error: null Apr 03 13:35:19 volumio volumio[876]: info: Apr 03 13:35:19 volumio volumio[876]: ---------------------------- MPD announces system playlist update Apr 03 13:35:19 volumio volumio[876]: info: Ignoring MPD Status Update Apr 03 13:35:19 volumio volumio[876]: info: ------------------------------ 5ms Apr 03 13:35:19 volumio volumio[876]: info: sendMpdCommand add "USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav" took 3 milliseconds Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand play Apr 03 13:35:19 volumio volumio[876]: info: Apr 03 13:35:19 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:35:19 volumio volumio[876]: info: ------------------------------ 8ms Apr 03 13:35:19 volumio volumio[876]: info: sendMpdCommand play took 6 milliseconds Apr 03 13:35:19 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:35:19 volumio volumio[876]: info: Apr 03 13:35:19 volumio volumio[876]: ---------------------------- MPD announces state update: player Apr 03 13:35:19 volumio volumio[876]: info: sendMpdCommand status took 18 milliseconds Apr 03 13:35:19 volumio volumio[876]: info: ControllerMpd::getState Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:35:19 volumio volumio[876]: info: sendMpdCommand status took 4 milliseconds Apr 03 13:35:19 volumio volumio[876]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::parseState Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:35:19 volumio volumio[876]: info: ControllerMpd::pushState Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::servicePushState Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:35:19 volumio volumio[876]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.When I Fall in Love.wav","artist":null,"album":null,"uri":"USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav","trackType":"wav"} Apr 03 13:35:19 volumio volumio[876]: verbose: CURRENT POSITION 0 Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::syncState stateService play Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus stop Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:35:19 volumio volumio[876]: info: ------------------------------ 42ms Apr 03 13:35:19 volumio volumio[876]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 03 13:35:19 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo Apr 03 13:35:19 volumio volumio[876]: info: ControllerMpd::pushState Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::servicePushState Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:35:19 volumio volumio[876]: verbose: STATE SERVICE {"status":"play","position":0,"seek":845,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.When I Fall in Love.wav","artist":null,"album":null,"uri":"USB/HIKSEMI/A067.《真空管录音30年》极品人声精选/01.When I Fall in Love.wav","trackType":"wav"} Apr 03 13:35:19 volumio volumio[876]: verbose: CURRENT POSITION 0 Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::syncState stateService play Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus play Apr 03 13:35:19 volumio volumio[876]: info: Received an update from plugin. extracting info from payload Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:35:19 volumio volumio[876]: info: CoreStateMachine::pushState Apr 03 13:35:19 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Apr 03 13:35:19 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Apr 03 13:35:19 volumio volumio[876]: info: ------------------------------ 52ms Apr 03 13:35:20 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:35:26 volumio wpa_supplicant[717]: wlan0: Failed to initiate sched scan Apr 03 13:35:27 volumio volumio[876]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 13:35:27 volumio volumio[876]: Error: connect ETIMEDOUT 157.240.16.50:443 Apr 03 13:35:27 volumio volumio[876]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 03 13:35:27 volumio volumio[876]: errno: -110, Apr 03 13:35:27 volumio volumio[876]: code: 'ETIMEDOUT', Apr 03 13:35:27 volumio volumio[876]: syscall: 'connect', Apr 03 13:35:27 volumio volumio[876]: address: '157.240.16.50', Apr 03 13:35:27 volumio volumio[876]: port: 443 Apr 03 13:35:27 volumio volumio[876]: } Apr 03 13:35:27 volumio volumio[876]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 13:35:28 volumio sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-03 13:34 Apr 03 13:35:28 volumio sudo[1430]: 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="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b" VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9" VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1" VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 02:51:41 PM CEST" VOLUMIO_VERSION="3.251" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e83cc5fcd68eb3ee4105ab0b8b3779ea"