-- 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"