-- Logs begin at Fri 2024-10-11 14:34:49 CEST, end at Sat 2024-10-19 19:18:04 CEST. -- Oct 19 19:17:00 volumio kernel: hwmon hwmon1: Voltage normalised Oct 19 19:17:00 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Oct 19 19:17:02 volumio volumio[1199]: info: handleBrowseUri took 1722 milliseconds Oct 19 19:17:02 volumio volumio[1199]: info: Preload queue cleared Oct 19 19:17:02 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 19 19:17:04 volumio wpa_supplicant[917]: wlan0: Failed to initiate sched scan Oct 19 19:17:08 volumio kernel: hwmon hwmon1: Voltage normalised Oct 19 19:17:08 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Oct 19 19:17:09 volumio volumio[1199]: info: handleBrowseUri took 790 milliseconds Oct 19 19:17:09 volumio volumio[1199]: info: Preload queue cleared Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677075 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677076 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677077 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677078 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677079 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677080 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677081 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677082 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677083 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677084 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677085 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677086 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677087 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677088 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677089 Oct 19 19:17:09 volumio volumio[1199]: info: Preloading song: qobuz://song/46677090 Oct 19 19:17:09 volumio volumio[1199]: info: Exploding uri qobuz://song/46677075 in service qobuz Oct 19 19:17:09 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:09 volumio volumio[1199]: info: Exploding uri qobuz://song/46677076 in service qobuz Oct 19 19:17:09 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:09 volumio volumio[1199]: info: Exploding uri qobuz://song/46677077 in service qobuz Oct 19 19:17:09 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:09 volumio volumio[1199]: info: Exploding uri qobuz://song/46677078 in service qobuz Oct 19 19:17:09 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:09 volumio volumio[1199]: info: Exploding uri qobuz://song/46677079 in service qobuz Oct 19 19:17:09 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:09 volumio volumio[1199]: info: Exploding uri qobuz://song/46677080 in service qobuz Oct 19 19:17:09 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:09 volumio volumio[1199]: info: Exploding uri qobuz://song/46677081 in service qobuz Oct 19 19:17:09 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:10 volumio volumio[1199]: info: Exploding uri qobuz://song/46677082 in service qobuz Oct 19 19:17:10 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:10 volumio volumio[1199]: info: Exploding uri qobuz://song/46677083 in service qobuz Oct 19 19:17:10 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:10 volumio volumio[1199]: info: Exploding uri qobuz://song/46677084 in service qobuz Oct 19 19:17:10 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:10 volumio volumio[1199]: info: Exploding uri qobuz://song/46677085 in service qobuz Oct 19 19:17:10 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:10 volumio volumio[1199]: info: Exploding uri qobuz://song/46677086 in service qobuz Oct 19 19:17:10 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:10 volumio volumio[1199]: info: Exploding uri qobuz://song/46677087 in service qobuz Oct 19 19:17:10 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:10 volumio volumio[1199]: info: Exploding uri qobuz://song/46677088 in service qobuz Oct 19 19:17:10 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 584 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: Exploding uri qobuz://song/46677089 in service qobuz Oct 19 19:17:10 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 609 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 762 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: Exploding uri qobuz://song/46677090 in service qobuz Oct 19 19:17:10 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 728 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 700 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 702 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 740 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 722 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 602 milliseconds Oct 19 19:17:10 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 811 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 768 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 580 milliseconds Oct 19 19:17:10 volumio volumio[1199]: info: explodeUri took 546 milliseconds Oct 19 19:17:11 volumio volumio[1199]: info: explodeUri took 660 milliseconds Oct 19 19:17:11 volumio volumio[1199]: info: explodeUri took 724 milliseconds Oct 19 19:17:11 volumio volumio[1199]: info: explodeUri took 795 milliseconds Oct 19 19:17:12 volumio wpa_supplicant[917]: wlan0: Failed to initiate sched scan Oct 19 19:17:12 volumio volumio[1199]: info: Preload queue cleared Oct 19 19:17:12 volumio volumio[1199]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 19 19:17:12 volumio volumio[1199]: info: CoreStateMachine::ClearQueue Oct 19 19:17:12 volumio volumio[1199]: info: CoreStateMachine::stop Oct 19 19:17:12 volumio volumio[1199]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 19:17:12 volumio volumio[1199]: info: CorePlayQueue::clearPlayQueue Oct 19 19:17:12 volumio volumio[1199]: info: CorePlayQueue::saveQueue Oct 19 19:17:12 volumio volumio[1199]: info: CoreCommandRouter::volumioPushQueue Oct 19 19:17:12 volumio volumio[1199]: info: CoreStateMachine::addQueueItems Oct 19 19:17:12 volumio volumio[1199]: info: CorePlayQueue::addQueueItems Oct 19 19:17:12 volumio volumio[1199]: info: Preload queue cleared Oct 19 19:17:12 volumio volumio[1199]: info: Adding Item to queue: qobuz://playlist/24914398 Oct 19 19:17:12 volumio volumio[1199]: info: Exploding uri qobuz://playlist/24914398 in service qobuz Oct 19 19:17:12 volumio volumio[1199]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 19 19:17:13 volumio volumio[1199]: info: explodeUri took 690 milliseconds Oct 19 19:17:13 volumio volumio[1199]: info: CoreCommandRouter::volumioPushQueue Oct 19 19:17:13 volumio volumio[1199]: info: CorePlayQueue::saveQueue Oct 19 19:17:13 volumio volumio[1199]: info: CoreStateMachine::updateTrackBlock Oct 19 19:17:13 volumio volumio[1199]: info: CorePlayQueue::getTrackBlock Oct 19 19:17:13 volumio volumio[1199]: info: CoreCommandRouter::volumioPlay Oct 19 19:17:13 volumio volumio[1199]: info: CoreStateMachine::play index 0 Oct 19 19:17:13 volumio volumio[1199]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 19:17:13 volumio volumio[1199]: info: CoreStateMachine::stop Oct 19 19:17:13 volumio volumio[1199]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 19:17:13 volumio volumio[1199]: info: CoreStateMachine::play index undefined Oct 19 19:17:13 volumio volumio[1199]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 19:17:13 volumio volumio[1199]: info: CorePlayQueue::getTrack 0 Oct 19 19:17:13 volumio volumio[1199]: info: CoreStateMachine::startPlaybackTimer Oct 19 19:17:13 volumio volumio[1199]: info: CorePlayQueue::getTrack 0 Oct 19 19:17:13 volumio volumio[1199]: info: [1729358233124] ControllerQobuz::clearAddPlayTrack Oct 19 19:17:13 volumio volumio[1199]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 19:17:13 volumio volumio[1199]: info: sendMpdCommand stop took 11 milliseconds Oct 19 19:17:13 volumio volumio[1199]: verbose: ControllerMpd::sendMpdCommand clear Oct 19 19:17:13 volumio volumio[1199]: info: Oct 19 19:17:13 volumio volumio[1199]: ---------------------------- MPD announces system playlist update Oct 19 19:17:13 volumio volumio[1199]: info: Ignoring MPD Status Update Oct 19 19:17:13 volumio volumio[1199]: info: sendMpdCommand clear took 3 milliseconds Oct 19 19:17:13 volumio volumio[1199]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/46677075" Oct 19 19:17:13 volumio volumio[1199]: error: updateQueue error: null Oct 19 19:17:13 volumio volumio[1199]: info: ------------------------------ 6ms Oct 19 19:17:13 volumio volumio[1199]: STREAMING PROXY: Handling url /?data=qobuz://song/46677075 Oct 19 19:17:13 volumio volumio[1199]: info: Executing endpoint getStreamUrlqobuz Oct 19 19:17:13 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Oct 19 19:17:13 volumio volumio[1199]: info: getStreamUrl took 622 milliseconds Oct 19 19:17:13 volumio volumio[1199]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=699334&eid=46677075&fmt=6&profile=raw&app_id=539451548&cid=1258948&etsp=1729361833&hmac=OsCbc6BMrI10006SsykdrJGYWto Oct 19 19:17:14 volumio volumio[1199]: STREAMING PROXY: Response: 200, length: 18716306 Oct 19 19:17:14 volumio volumio[1199]: STREAMING PROXY: Client dropped request, destroying Oct 19 19:17:14 volumio volumio[1199]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/46677075" Oct 19 19:17:14 volumio volumio[1199]: info: Oct 19 19:17:14 volumio volumio[1199]: ---------------------------- MPD announces system playlist update Oct 19 19:17:14 volumio volumio[1199]: info: Ignoring MPD Status Update Oct 19 19:17:14 volumio volumio[1199]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/46677075" took 2 milliseconds Oct 19 19:17:14 volumio volumio[1199]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 19 19:17:14 volumio volumio[1199]: verbose: ControllerMpd::sendMpdCommand play Oct 19 19:17:14 volumio volumio[1199]: info: ------------------------------ 3ms Oct 19 19:17:14 volumio volumio[1199]: info: sendMpdCommand play took 2 milliseconds Oct 19 19:17:14 volumio volumio[1199]: STREAMING PROXY: Handling url /?data=qobuz://song/46677075 Oct 19 19:17:14 volumio volumio[1199]: info: Executing endpoint getStreamUrlqobuz Oct 19 19:17:14 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Oct 19 19:17:14 volumio volumio[1199]: info: getStreamUrl took 473 milliseconds Oct 19 19:17:14 volumio volumio[1199]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=699334&eid=46677075&fmt=6&profile=raw&app_id=539451548&cid=1258948&etsp=1729361834&hmac=miuf-j6YBwcAFBZuXwI-I06bR2g Oct 19 19:17:14 volumio volumio[1199]: STREAMING PROXY: Response: 200, length: 18716306 Oct 19 19:17:14 volumio volumio[1199]: info: Oct 19 19:17:14 volumio volumio[1199]: ---------------------------- MPD announces state update: player Oct 19 19:17:14 volumio volumio[1199]: info: ControllerMpd::getState Oct 19 19:17:14 volumio volumio[1199]: verbose: ControllerMpd::sendMpdCommand status Oct 19 19:17:14 volumio volumio[1199]: info: FusionDsp - ---- read samplerate, raw: Oct 19 19:17:14 volumio volumio[1199]: error: FusionDsp - invalid sample rate Oct 19 19:17:14 volumio volumio[1199]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 19 19:17:14 volumio volumio[1199]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 19 19:17:14 volumio volumio[1199]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 19 19:17:14 volumio volumio[1199]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 19 19:17:14 volumio volumio[1199]: info: Oct 19 19:17:14 volumio volumio[1199]: ---------------------------- MPD announces state update: player Oct 19 19:17:14 volumio volumio[1199]: info: sendMpdCommand status took 41 milliseconds Oct 19 19:17:14 volumio volumio[1199]: info: ControllerMpd::getState Oct 19 19:17:14 volumio volumio[1199]: verbose: ControllerMpd::sendMpdCommand status Oct 19 19:17:14 volumio volumio[1199]: verbose: ControllerMpd::parseState Oct 19 19:17:14 volumio volumio[1199]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 19:17:14 volumio volumio[1199]: info: sendMpdCommand status took 7 milliseconds Oct 19 19:17:14 volumio volumio[1199]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 19 19:17:14 volumio volumio[1199]: verbose: ControllerMpd::parseState Oct 19 19:17:14 volumio volumio[1199]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 19:17:14 volumio volumio[1199]: verbose: ControllerMpd::parseTrackInfo Oct 19 19:17:14 volumio volumio[1199]: info: ControllerMpd::pushState Oct 19 19:17:14 volumio volumio[1199]: info: CoreCommandRouter::servicePushState Oct 19 19:17:14 volumio volumio[1199]: info: CorePlayQueue::getTrack 0 Oct 19 19:17:14 volumio volumio[1199]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"46677075","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/46677075","trackType":"qobuz"} Oct 19 19:17:14 volumio volumio[1199]: verbose: CURRENT POSITION 0 Oct 19 19:17:14 volumio volumio[1199]: info: CoreStateMachine::syncState stateService play Oct 19 19:17:14 volumio volumio[1199]: info: CoreStateMachine::syncState currentStatus stop Oct 19 19:17:14 volumio volumio[1199]: info: ------------------------------ 57ms Oct 19 19:17:14 volumio volumio[1199]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 19 19:17:14 volumio volumio[1199]: verbose: ControllerMpd::parseTrackInfo Oct 19 19:17:14 volumio volumio[1199]: info: ControllerMpd::pushState Oct 19 19:17:14 volumio volumio[1199]: info: CoreCommandRouter::servicePushState Oct 19 19:17:14 volumio volumio[1199]: info: CorePlayQueue::getTrack 0 Oct 19 19:17:14 volumio volumio[1199]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":161,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"993 Kbps","isStreaming":false,"title":"46677075","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/46677075","trackType":"qobuz"} Oct 19 19:17:14 volumio volumio[1199]: verbose: CURRENT POSITION 0 Oct 19 19:17:14 volumio volumio[1199]: info: CoreStateMachine::syncState stateService play Oct 19 19:17:14 volumio volumio[1199]: info: CoreStateMachine::syncState currentStatus play Oct 19 19:17:14 volumio volumio[1199]: info: Received an update from plugin. extracting info from payload Oct 19 19:17:14 volumio volumio[1199]: info: CoreStateMachine::pushState Oct 19 19:17:14 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 19:17:14 volumio volumio[1199]: info: CoreCommandRouter::volumioPushState Oct 19 19:17:14 volumio volumio[1199]: info: CoreStateMachine::pushState Oct 19 19:17:14 volumio volumio[1199]: info: CoreCommandRouter::volumioPushState Oct 19 19:17:14 volumio volumio[1199]: info: ------------------------------ 47ms Oct 19 19:17:15 volumio volumio[1199]: STREAMING PROXY: Client dropped request, destroying Oct 19 19:17:19 volumio wpa_supplicant[917]: wlan0: Failed to initiate sched scan Oct 19 19:17:20 volumio volumiossh-tunnel[1650]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Oct 19 19:17:23 volumio kernel: hwmon hwmon1: Voltage normalised Oct 19 19:17:25 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 19 19:17:27 volumio wpa_supplicant[917]: wlan0: Failed to initiate sched scan Oct 19 19:17:31 volumio kernel: hwmon hwmon1: Voltage normalised Oct 19 19:17:33 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 19 19:17:34 volumio wpa_supplicant[917]: wlan0: Failed to initiate sched scan Oct 19 19:17:39 volumio kernel: hwmon hwmon1: Voltage normalised Oct 19 19:17:42 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 19 19:17:42 volumio wpa_supplicant[917]: wlan0: Failed to initiate sched scan Oct 19 19:17:46 volumio kernel: hwmon hwmon1: Voltage normalised Oct 19 19:17:48 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 19 19:17:49 volumio wpa_supplicant[917]: wlan0: Failed to initiate sched scan Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 19:17:56 volumio volumio[1199]: info: Retrieving Cloud Streaming UI Oct 19 19:17:56 volumio volumio[1199]: info: Getting Tidal Cloud Configuration Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 19:17:56 volumio volumio[1199]: info: Getting Qobuz Cloud Configuration Oct 19 19:17:56 volumio volumio[1199]: info: Asking plugin for UI Config Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 19:17:56 volumio volumio[1199]: info: Getting Spotify Cloud Configuration Oct 19 19:17:56 volumio volumio[1199]: info: Asking plugin for UI Config Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 19:17:56 volumio volumio[1199]: info: Saving Spotify Acccount Oct 19 19:17:56 volumio volumio[1199]: info: Got it Oct 19 19:17:56 volumio volumio[1199]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 19 19:17:56 volumio volumio[1199]: info: Got Tidal Cloud Configuration Oct 19 19:17:56 volumio volumio[1199]: info: Got it Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::volumioGetBrowseSources Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::volumioGetBrowseSources Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::volumioGetBrowseSources Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 19:17:56 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 19 19:17:57 volumio wpa_supplicant[917]: wlan0: Failed to initiate sched scan Oct 19 19:18:00 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 19:18:02 volumio volumio[1199]: info: Disabling MyMusic plugin upnp Oct 19 19:18:02 volumio sudo[1795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 19 19:18:02 volumio sudo[1795]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:18:02 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Oct 19 19:18:02 volumio volumio[1199]: error: Upnp client error: Error: This socket has been ended by the other party Oct 19 19:18:02 volumio volumio[1199]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 19 19:18:03 volumio volumio[1199]: info: Enabling MyMusic plugin upnp Oct 19 19:18:03 volumio volumio[1199]: info: Enabling plugin upnp Oct 19 19:18:03 volumio volumio[1199]: info: Loading plugin "upnp"... Oct 19 19:18:03 volumio volumio[1199]: info: [1729358283216] Starting Upmpd Daemon Oct 19 19:18:03 volumio volumio[1199]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 19 19:18:03 volumio volumio[1199]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 19:18:03 volumio volumio[1199]: Error: listen EADDRINUSE: address already in use :::6599 Oct 19 19:18:03 volumio volumio[1199]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Oct 19 19:18:03 volumio volumio[1199]: at listenInCluster (net.js:1366:12) Oct 19 19:18:03 volumio volumio[1199]: at Server.listen (net.js:1452:7) Oct 19 19:18:03 volumio volumio[1199]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Oct 19 19:18:03 volumio volumio[1199]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Oct 19 19:18:03 volumio volumio[1199]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 19 19:18:03 volumio volumio[1199]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 19 19:18:03 volumio volumio[1199]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Oct 19 19:18:03 volumio volumio[1199]: code: 'EADDRINUSE', Oct 19 19:18:03 volumio volumio[1199]: errno: -98, Oct 19 19:18:03 volumio volumio[1199]: syscall: 'listen', Oct 19 19:18:03 volumio volumio[1199]: address: '::', Oct 19 19:18:03 volumio volumio[1199]: port: 6599 Oct 19 19:18:03 volumio volumio[1199]: } Oct 19 19:18:03 volumio volumio[1199]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 19:18:04 volumio sudo[1806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-19 19:17 Oct 19 19:18:04 volumio sudo[1806]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"