-- Logs begin at Wed 2024-09-04 19:03:06 HKT, end at Fri 2024-09-06 22:03:59 HKT. -- Sep 06 22:02:06 volumio ntpd[743]: Soliciting pool server 2606:4700:f1::1 Sep 06 22:02:22 volumio volumio[776]: info: CorePlayQueue::getTrack 1 Sep 06 22:02:22 volumio volumio[776]: info: CorePlayQueue::getTrack 2 Sep 06 22:02:22 volumio volumio[776]: info: Prefetching next song Sep 06 22:02:22 volumio volumio[776]: info: Doing Prefetch in UPNP Sep 06 22:02:22 volumio volumio[776]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.11:10747/%5C%E9%9F%B3%E6%A8%82%5C%E4%BD%8D%E7%BD%AE%5CHD%3A%E6%96%B0%E5%A2%9E%E7%A3%81%E7%A2%9F%E5%8D%80%20(D%3A)%5CBaiduNetdiskDownload%5C%E7%BB%BC%E5%90%88HIFI%E6%97%A0%E6%8D%9F%E5%A4%A7%E5%90%88%E9%9B%86-002%5CA344.%E5%88%98%E4%BA%AE%E9%B9%AD%E3%80%8A%E7%A6%BB%E5%AE%B6%E4%BA%94%E7%99%BE%E9%87%8C%E3%80%8B%E6%B6%82%E9%B8%A6%E6%83%85%E6%84%9F%E7%94%B7%E5%A3%B0%5CItemID=23118.wav" Sep 06 22:02:22 volumio volumio[776]: info: Sep 06 22:02:22 volumio volumio[776]: ---------------------------- MPD announces system playlist update Sep 06 22:02:22 volumio volumio[776]: info: Ignoring MPD Status Update Sep 06 22:02:22 volumio volumio[776]: info: sendMpdCommand add "http://192.168.3.11:10747/%5C%E9%9F%B3%E6%A8%82%5C%E4%BD%8D%E7%BD%AE%5CHD%3A%E6%96%B0%E5%A2%9E%E7%A3%81%E7%A2%9F%E5%8D%80%20(D%3A)%5CBaiduNetdiskDownload%5C%E7%BB%BC%E5%90%88HIFI%E6%97%A0%E6%8D%9F%E5%A4%A7%E5%90%88%E9%9B%86-002%5CA344.%E5%88%98%E4%BA%AE%E9%B9%AD%E3%80%8A%E7%A6%BB%E5%AE%B6%E4%BA%94%E7%99%BE%E9%87%8C%E3%80%8B%E6%B6%82%E9%B8%A6%E6%83%85%E6%84%9F%E7%94%B7%E5%A3%B0%5CItemID=23118.wav" took 13 milliseconds Sep 06 22:02:22 volumio volumio[776]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 06 22:02:22 volumio volumio[776]: info: Sep 06 22:02:22 volumio volumio[776]: ---------------------------- MPD announces state update: options Sep 06 22:02:22 volumio volumio[776]: info: ------------------------------ 12ms Sep 06 22:02:22 volumio volumio[776]: info: sendMpdCommand consume 1 took 7 milliseconds Sep 06 22:02:22 volumio volumio[776]: info: ControllerMpd::getState Sep 06 22:02:22 volumio volumio[776]: verbose: ControllerMpd::sendMpdCommand status Sep 06 22:02:22 volumio volumio[776]: info: sendMpdCommand status took 3 milliseconds Sep 06 22:02:22 volumio volumio[776]: verbose: ControllerMpd::parseState Sep 06 22:02:22 volumio volumio[776]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 22:02:22 volumio volumio[776]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 06 22:02:22 volumio volumio[776]: verbose: ControllerMpd::parseTrackInfo Sep 06 22:02:22 volumio volumio[776]: info: ControllerMpd::pushState Sep 06 22:02:22 volumio volumio[776]: info: CoreCommandRouter::servicePushState Sep 06 22:02:22 volumio volumio[776]: info: CorePlayQueue::getTrack 1 Sep 06 22:02:22 volumio volumio[776]: verbose: STATE SERVICE {"status":"play","position":7,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"%5C%E9%9F%B3%E6%A8%82%5C%E4%BD%8D%E7%BD%AE%5CHD%3A%E6%96%B0%E5%A2%9E%E7%A3%81%E7%A2%9F%E5%8D%80%20(D%3A)%5CBaiduNetdiskDownload%5C%E7%BB%BC%E5%90%88HIFI%E6%97%A0%E6%8D%9F%E5%A4%A7%E5%90%88%E9%9B%86-002%5CA344.%E5%88%98%E4%BA%AE%E9%B9%AD%E3%80%8A%E7%A6%BB%E5%AE%B6%E4%BA%94%E7%99%BE%E9%87%8C%E3%80%8B%E6%B6%82%E9%B8%A6%E6%83%85%E6%84%9F%E7%94%B7%E5%A3%B0%5CItemID=23114.wav","artist":null,"album":null,"uri":"http://192.168.3.11:10747/%5C%E9%9F%B3%E6%A8%82%5C%E4%BD%8D%E7%BD%AE%5CHD%3A%E6%96%B0%E5%A2%9E%E7%A3%81%E7%A2%9F%E5%8D%80%20(D%3A)%5CBaiduNetdiskDownload%5C%E7%BB%BC%E5%90%88HIFI%E6%97%A0%E6%8D%9F%E5%A4%A7%E5%90%88%E9%9B%86-002%5CA344.%E5%88%98%E4%BA%AE%E9%B9%AD%E3%80%8A%E7%A6%BB%E5%AE%B6%E4%BA%94%E7%99%BE%E9%87%8C%E3%80%8B%E6%B6%82%E9%B8%A6%E6%83%85%E6%84%9F%E7%94%B7%E5%A3%B0%5CItemID=23114.wav","trackType":"wav"} Sep 06 22:02:22 volumio volumio[776]: verbose: CURRENT POSITION 1 Sep 06 22:02:22 volumio volumio[776]: info: CoreStateMachine::syncState stateService play Sep 06 22:02:22 volumio volumio[776]: info: CoreStateMachine::syncState currentStatus play Sep 06 22:02:22 volumio volumio[776]: info: Received an update from plugin. extracting info from payload Sep 06 22:02:22 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:02:22 volumio volumio[776]: info: CorePlayQueue::getTrack 1 Sep 06 22:02:22 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:02:22 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:02:22 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:02:22 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:02:22 volumio volumio[776]: info: ------------------------------ 40ms Sep 06 22:02:25 volumio volumio[1098]: 0 Sep 06 22:02:25 volumio volumio[1098]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 06 22:02:25 volumio volumio[1098]: Dload Upload Total Spent Left Speed Sep 06 22:02:25 volumio volumio[776]: info: Sep 06 22:02:25 volumio volumio[776]: ---------------------------- Client requests Volume 1 Sep 06 22:02:25 volumio volumio[776]: info: VolumeController::SetAlsaVolume1 Sep 06 22:02:25 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:02:25 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:02:25 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:02:25 volumio volumio[1098]: [158B blob data] Sep 06 22:02:25 volumio volumio[1098]: {"time":1725631345537,"response":"volume Success"}1 Sep 06 22:02:25 volumio volumio[776]: info: Sep 06 22:02:25 volumio volumio[776]: ---------------------------- MPD announces system playlist update Sep 06 22:02:25 volumio volumio[776]: info: Ignoring MPD Status Update Sep 06 22:02:25 volumio volumio[776]: info: ------------------------------ 3ms Sep 06 22:02:27 volumio volumio[776]: info: CoreStateMachine::startPlaybackTimer Sep 06 22:02:27 volumio volumio[776]: info: CorePlayQueue::getTrack 2 Sep 06 22:02:27 volumio volumio[1098]: 100 Sep 06 22:02:27 volumio volumio[1098]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 06 22:02:27 volumio volumio[1098]: Dload Upload Total Spent Left Speed Sep 06 22:02:27 volumio volumio[776]: info: Sep 06 22:02:27 volumio volumio[776]: ---------------------------- Client requests Volume 100 Sep 06 22:02:27 volumio volumio[776]: info: VolumeController::SetAlsaVolume100 Sep 06 22:02:27 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:02:27 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:02:27 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:02:27 volumio volumio[1098]: [158B blob data] Sep 06 22:02:27 volumio volumio[1098]: {"time":1725631347797,"response":"volume Success"}100 Sep 06 22:02:27 volumio volumio[1098]: 53 Sep 06 22:02:27 volumio volumio[1098]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 06 22:02:27 volumio volumio[1098]: Dload Upload Total Spent Left Speed Sep 06 22:02:27 volumio volumio[776]: info: Sep 06 22:02:27 volumio volumio[776]: ---------------------------- Client requests Volume 53 Sep 06 22:02:27 volumio volumio[776]: info: VolumeController::SetAlsaVolume53 Sep 06 22:02:27 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:02:27 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:02:27 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:02:27 volumio volumio[1098]: [158B blob data] Sep 06 22:02:27 volumio volumio[1098]: {"time":1725631347892,"response":"volume Success"}53 Sep 06 22:02:27 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:02:27 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:02:27 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:02:28 volumio volumio[1098]: 68 Sep 06 22:02:28 volumio volumio[1098]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 06 22:02:28 volumio volumio[1098]: Dload Upload Total Spent Left Speed Sep 06 22:02:28 volumio volumio[776]: info: Sep 06 22:02:28 volumio volumio[776]: ---------------------------- Client requests Volume 68 Sep 06 22:02:28 volumio volumio[776]: info: VolumeController::SetAlsaVolume68 Sep 06 22:02:28 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:02:28 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:02:28 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:02:28 volumio volumio[1098]: [158B blob data] Sep 06 22:02:28 volumio volumio[1098]: {"time":1725631348917,"response":"volume Success"}68 Sep 06 22:02:30 volumio volumio[1098]: 81 Sep 06 22:02:30 volumio volumio[1098]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 06 22:02:30 volumio volumio[1098]: Dload Upload Total Spent Left Speed Sep 06 22:02:30 volumio volumio[776]: info: Sep 06 22:02:30 volumio volumio[776]: ---------------------------- Client requests Volume 81 Sep 06 22:02:30 volumio volumio[776]: info: VolumeController::SetAlsaVolume81 Sep 06 22:02:30 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:02:30 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:02:30 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:02:30 volumio volumio[1098]: [158B blob data] Sep 06 22:02:30 volumio volumio[1098]: {"time":1725631350833,"response":"volume Success"}81 Sep 06 22:02:34 volumio volumio[1098]: 82 Sep 06 22:02:34 volumio volumio[1098]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 06 22:02:34 volumio volumio[1098]: Dload Upload Total Spent Left Speed Sep 06 22:02:34 volumio volumio[776]: info: Sep 06 22:02:34 volumio volumio[776]: ---------------------------- Client requests Volume 82 Sep 06 22:02:34 volumio volumio[776]: info: VolumeController::SetAlsaVolume82 Sep 06 22:02:34 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:02:34 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:02:34 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:02:34 volumio volumio[1098]: [158B blob data] Sep 06 22:02:34 volumio volumio[1098]: {"time":1725631354481,"response":"volume Success"}82 Sep 06 22:02:34 volumio volumio[1098]: 100 Sep 06 22:02:34 volumio volumio[1098]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 06 22:02:34 volumio volumio[1098]: Dload Upload Total Spent Left Speed Sep 06 22:02:34 volumio volumio[776]: info: Sep 06 22:02:34 volumio volumio[776]: ---------------------------- Client requests Volume 100 Sep 06 22:02:34 volumio volumio[776]: info: VolumeController::SetAlsaVolume100 Sep 06 22:02:34 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:02:34 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:02:34 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:02:34 volumio volumio[1098]: [158B blob data] Sep 06 22:02:34 volumio volumio[1098]: {"time":1725631354782,"response":"volume Success"}100 Sep 06 22:02:36 volumio volumio[776]: info: Sep 06 22:02:36 volumio volumio[776]: ---------------------------- MPD announces system playlist update Sep 06 22:02:36 volumio volumio[776]: info: Ignoring MPD Status Update Sep 06 22:02:36 volumio volumio[776]: info: ------------------------------ 4ms Sep 06 22:02:47 volumio volumio[776]: info: Sep 06 22:02:47 volumio volumio[776]: ---------------------------- MPD announces system playlist update Sep 06 22:02:47 volumio volumio[776]: info: Ignoring MPD Status Update Sep 06 22:02:47 volumio volumio[776]: info: ------------------------------ 4ms Sep 06 22:02:58 volumio volumio[776]: info: Sep 06 22:02:58 volumio volumio[776]: ---------------------------- MPD announces system playlist update Sep 06 22:02:58 volumio volumio[776]: info: Ignoring MPD Status Update Sep 06 22:02:58 volumio volumio[776]: info: ------------------------------ 4ms Sep 06 22:03:09 volumio volumio[776]: info: Sep 06 22:03:09 volumio volumio[776]: ---------------------------- MPD announces system playlist update Sep 06 22:03:09 volumio volumio[776]: info: Ignoring MPD Status Update Sep 06 22:03:09 volumio volumio[776]: info: ------------------------------ 5ms Sep 06 22:03:10 volumio ntpd[743]: Soliciting pool server 2001:ac8:a:23:0:1:0:26 Sep 06 22:03:17 volumio volumio[776]: info: Sep 06 22:03:17 volumio volumio[776]: ---------------------------- MPD announces state update: player Sep 06 22:03:17 volumio volumio[776]: info: ControllerMpd::getState Sep 06 22:03:17 volumio volumio[776]: verbose: ControllerMpd::sendMpdCommand status Sep 06 22:03:17 volumio volumio[776]: info: Sep 06 22:03:17 volumio volumio[776]: ---------------------------- MPD announces state update: player Sep 06 22:03:17 volumio volumio[776]: info: ControllerMpd::getState Sep 06 22:03:17 volumio volumio[776]: verbose: ControllerMpd::sendMpdCommand status Sep 06 22:03:17 volumio volumio[776]: info: sendMpdCommand status took 5 milliseconds Sep 06 22:03:17 volumio volumio[776]: verbose: ControllerMpd::parseState Sep 06 22:03:17 volumio volumio[776]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 22:03:17 volumio volumio[776]: info: sendMpdCommand status took 8 milliseconds Sep 06 22:03:17 volumio volumio[776]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 06 22:03:17 volumio volumio[776]: verbose: ControllerMpd::parseState Sep 06 22:03:17 volumio volumio[776]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 22:03:17 volumio volumio[776]: verbose: ControllerMpd::parseTrackInfo Sep 06 22:03:17 volumio volumio[776]: info: ControllerMpd::pushState Sep 06 22:03:17 volumio volumio[776]: info: CoreCommandRouter::servicePushState Sep 06 22:03:17 volumio volumio[776]: info: CorePlayQueue::getTrack 2 Sep 06 22:03:17 volumio volumio[776]: verbose: STATE SERVICE {"status":"play","position":7,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"%5C%E9%9F%B3%E6%A8%82%5C%E4%BD%8D%E7%BD%AE%5CHD%3A%E6%96%B0%E5%A2%9E%E7%A3%81%E7%A2%9F%E5%8D%80%20(D%3A)%5CBaiduNetdiskDownload%5C%E7%BB%BC%E5%90%88HIFI%E6%97%A0%E6%8D%9F%E5%A4%A7%E5%90%88%E9%9B%86-002%5CA351.LPCD%2045%E3%80%8ABeyond%E3%80%8B%E7%BB%9D%E7%89%88%E7%B2%BE%E9%80%89%E6%8E%A8%E8%8D%90~~%5CItemID=23216.wav","artist":null,"album":null,"uri":"http://192.168.3.11:10747/%5C%E9%9F%B3%E6%A8%82%5C%E4%BD%8D%E7%BD%AE%5CHD%3A%E6%96%B0%E5%A2%9E%E7%A3%81%E7%A2%9F%E5%8D%80%20(D%3A)%5CBaiduNetdiskDownload%5C%E7%BB%BC%E5%90%88HIFI%E6%97%A0%E6%8D%9F%E5%A4%A7%E5%90%88%E9%9B%86-002%5CA351.LPCD%2045%E3%80%8ABeyond%E3%80%8B%E7%BB%9D%E7%89%88%E7%B2%BE%E9%80%89%E6%8E%A8%E8%8D%90~~%5CItemID=23216.wav","trackType":"wav"} Sep 06 22:03:17 volumio volumio[776]: verbose: CURRENT POSITION 2 Sep 06 22:03:17 volumio volumio[776]: info: CoreStateMachine::syncState stateService play Sep 06 22:03:17 volumio volumio[776]: info: CoreStateMachine::syncState currentStatus play Sep 06 22:03:17 volumio volumio[776]: info: Received an update from plugin. extracting info from payload Sep 06 22:03:17 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:03:17 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:03:17 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:03:17 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:03:17 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:03:17 volumio volumio[776]: info: ------------------------------ 73ms Sep 06 22:03:17 volumio volumio[776]: info: sendMpdCommand playlistinfo took 37 milliseconds Sep 06 22:03:17 volumio volumio[776]: verbose: ControllerMpd::parseTrackInfo Sep 06 22:03:17 volumio volumio[776]: info: ControllerMpd::pushState Sep 06 22:03:17 volumio volumio[776]: info: CoreCommandRouter::servicePushState Sep 06 22:03:17 volumio volumio[776]: info: CorePlayQueue::getTrack 2 Sep 06 22:03:17 volumio volumio[776]: verbose: STATE SERVICE {"status":"play","position":7,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"%5C%E9%9F%B3%E6%A8%82%5C%E4%BD%8D%E7%BD%AE%5CHD%3A%E6%96%B0%E5%A2%9E%E7%A3%81%E7%A2%9F%E5%8D%80%20(D%3A)%5CBaiduNetdiskDownload%5C%E7%BB%BC%E5%90%88HIFI%E6%97%A0%E6%8D%9F%E5%A4%A7%E5%90%88%E9%9B%86-002%5CA351.LPCD%2045%E3%80%8ABeyond%E3%80%8B%E7%BB%9D%E7%89%88%E7%B2%BE%E9%80%89%E6%8E%A8%E8%8D%90~~%5CItemID=23216.wav","artist":null,"album":null,"uri":"http://192.168.3.11:10747/%5C%E9%9F%B3%E6%A8%82%5C%E4%BD%8D%E7%BD%AE%5CHD%3A%E6%96%B0%E5%A2%9E%E7%A3%81%E7%A2%9F%E5%8D%80%20(D%3A)%5CBaiduNetdiskDownload%5C%E7%BB%BC%E5%90%88HIFI%E6%97%A0%E6%8D%9F%E5%A4%A7%E5%90%88%E9%9B%86-002%5CA351.LPCD%2045%E3%80%8ABeyond%E3%80%8B%E7%BB%9D%E7%89%88%E7%B2%BE%E9%80%89%E6%8E%A8%E8%8D%90~~%5CItemID=23216.wav","trackType":"wav"} Sep 06 22:03:17 volumio volumio[776]: verbose: CURRENT POSITION 2 Sep 06 22:03:17 volumio volumio[776]: info: CoreStateMachine::syncState stateService play Sep 06 22:03:17 volumio volumio[776]: info: CoreStateMachine::syncState currentStatus play Sep 06 22:03:17 volumio volumio[776]: info: Received an update from plugin. extracting info from payload Sep 06 22:03:17 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:03:17 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 22:03:17 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:03:17 volumio volumio[776]: info: CoreStateMachine::pushState Sep 06 22:03:17 volumio volumio[776]: info: CoreCommandRouter::volumioPushState Sep 06 22:03:17 volumio volumio[776]: info: ------------------------------ 334ms Sep 06 22:03:41 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 22:03:41 volumio volumio[776]: info: Preload queue cleared Sep 06 22:03:42 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 22:03:43 volumio volumio[776]: info: Preload queue cleared Sep 06 22:03:48 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 22:03:49 volumio volumio[776]: info: Preload queue cleared Sep 06 22:03:49 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 22:03:53 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 22:03:53 volumio volumio[776]: info: Preload queue cleared Sep 06 22:03:53 volumio volumio[776]: info: Preload queue cleared Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:54 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:55 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:55 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:55 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:55 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:55 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:55 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:55 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:55 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:55 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:55 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:56 volumio volumio[776]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Sep 06 22:03:58 volumio volumio[776]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 06 22:03:58 volumio volumio[776]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 22:03:58 volumio volumio[776]: TypeError: Cannot read property 'length' of undefined Sep 06 22:03:58 volumio volumio[776]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Sep 06 22:03:58 volumio volumio[776]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Sep 06 22:03:58 volumio volumio[776]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Sep 06 22:03:58 volumio volumio[776]: at Parser.emit (events.js:315:20) Sep 06 22:03:58 volumio volumio[776]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Sep 06 22:03:58 volumio volumio[776]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Sep 06 22:03:58 volumio volumio[776]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Sep 06 22:03:58 volumio volumio[776]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Sep 06 22:03:58 volumio volumio[776]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Sep 06 22:03:58 volumio volumio[776]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Sep 06 22:03:58 volumio volumio[776]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Sep 06 22:03:58 volumio volumio[776]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Sep 06 22:03:58 volumio volumio[776]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Sep 06 22:03:58 volumio volumio[776]: at IncomingMessage.emit (events.js:327:22) Sep 06 22:03:58 volumio volumio[776]: at endReadableNT (internal/streams/readable.js:1327:12) Sep 06 22:03:58 volumio volumio[776]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Sep 06 22:03:58 volumio volumio[776]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 22:03:59 volumio sudo[4786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 22:02 Sep 06 22:03:59 volumio sudo[4786]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"