-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2025-04-13 13:03:47 CEST. -- Apr 13 13:03:15 volumio volumio[887]: error: Upnp client error: Error: This socket has been ended by the other party Apr 13 13:03:24 volumio volumio[887]: info: Clearing queue after UPNP request Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::ClearQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::stop Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::clearPlayQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::saveQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: error: updateQueue error: null Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 2ms Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 1ms Apr 13 13:03:24 volumio volumio[887]: info: Starting UPNP Playback Apr 13 13:03:24 volumio volumio[887]: info: Preparing playback through UPNP Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetState Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getTrack 0 Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 2ms Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 1ms Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 2ms Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 1ms Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 2ms Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 1ms Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 2ms Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 1ms Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 2ms Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 1ms Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces system playlist update Apr 13 13:03:24 volumio volumio[887]: info: Ignoring MPD Status Update Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 2ms Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 1ms Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::getState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::getState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::getState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 13 13:03:24 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::getState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 13 13:03:24 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 13 13:03:24 volumio volumio[887]: info: sendMpdCommand status took 5 milliseconds Apr 13 13:03:24 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 13 13:03:24 volumio volumio[887]: verbose: In UPNP mode Apr 13 13:03:24 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Perfect Sense, Pt. II","artist":"Roger Waters","album":"Amused To Death","uri":"http://192.168.1.141:57645/proxy/qobuz/7C3138DB1A7530786FDAC49C0B1FDDDA.flac?proxy=false","trackType":"qobuz"} Apr 13 13:03:24 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 7ms Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::getState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 13 13:03:24 volumio volumio[887]: info: Apr 13 13:03:24 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::getState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 13 13:03:24 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 13 13:03:24 volumio volumio[887]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 13 13:03:24 volumio volumio[887]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 13 13:03:24 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 13 13:03:24 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 13 13:03:24 volumio volumio[887]: verbose: In UPNP mode Apr 13 13:03:24 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Perfect Sense, Pt. II","artist":"Roger Waters","album":"Amused To Death","uri":"http://192.168.1.141:57645/proxy/qobuz/7C3138DB1A7530786FDAC49C0B1FDDDA.flac?proxy=false","trackType":"qobuz"} Apr 13 13:03:24 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 13 13:03:24 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 13 13:03:24 volumio volumio[887]: verbose: In UPNP mode Apr 13 13:03:24 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Perfect Sense, Pt. II","artist":"Roger Waters","album":"Amused To Death","uri":"http://192.168.1.141:57645/proxy/qobuz/7C3138DB1A7530786FDAC49C0B1FDDDA.flac?proxy=false","trackType":"qobuz"} Apr 13 13:03:24 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 13 13:03:24 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 21ms Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 20ms Apr 13 13:03:24 volumio volumio[887]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 13 13:03:24 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 13 13:03:24 volumio volumio[887]: verbose: In UPNP mode Apr 13 13:03:24 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Perfect Sense, Pt. II","artist":"Roger Waters","album":"Amused To Death","uri":"http://192.168.1.141:57645/proxy/qobuz/7C3138DB1A7530786FDAC49C0B1FDDDA.flac?proxy=false","trackType":"qobuz"} Apr 13 13:03:24 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 13 13:03:24 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 13 13:03:24 volumio volumio[887]: verbose: In UPNP mode Apr 13 13:03:24 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Perfect Sense, Pt. II","artist":"Roger Waters","album":"Amused To Death","uri":"http://192.168.1.141:57645/proxy/qobuz/7C3138DB1A7530786FDAC49C0B1FDDDA.flac?proxy=false","trackType":"qobuz"} Apr 13 13:03:24 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 13 13:03:24 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: ControllerMpd::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 13 13:03:24 volumio volumio[887]: verbose: In UPNP mode Apr 13 13:03:24 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Perfect Sense, Pt. II","artist":"Roger Waters","album":"Amused To Death","uri":"http://192.168.1.141:57645/proxy/qobuz/7C3138DB1A7530786FDAC49C0B1FDDDA.flac?proxy=false","trackType":"qobuz"} Apr 13 13:03:24 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState stateService play Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 13 13:03:24 volumio volumio[887]: info: Received an update from plugin. extracting info from payload Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 39ms Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 38ms Apr 13 13:03:24 volumio volumio[887]: info: ------------------------------ 37ms Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:24 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:24 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:25 volumio volumio[887]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 13 13:03:25 volumio volumio[887]: info: Apr 13 13:03:25 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 13 13:03:25 volumio volumio[887]: info: ControllerMpd::getState Apr 13 13:03:25 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 13 13:03:25 volumio volumio[887]: info: Apr 13 13:03:25 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 13 13:03:25 volumio volumio[887]: info: ControllerMpd::getState Apr 13 13:03:25 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 13 13:03:25 volumio volumio[887]: info: Apr 13 13:03:25 volumio volumio[887]: ---------------------------- MPD announces state update: player Apr 13 13:03:25 volumio volumio[887]: info: ControllerMpd::getState Apr 13 13:03:25 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status Apr 13 13:03:25 volumio volumio[887]: info: sendMpdCommand status took 5 milliseconds Apr 13 13:03:25 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds Apr 13 13:03:25 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 13 13:03:25 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 13:03:25 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 13 13:03:25 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 13:03:25 volumio volumio[887]: verbose: ControllerMpd::parseState Apr 13 13:03:25 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 13:03:25 volumio volumio[887]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 13 13:03:25 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo Apr 13 13:03:25 volumio volumio[887]: info: ControllerMpd::pushState Apr 13 13:03:25 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 13 13:03:25 volumio volumio[887]: verbose: In UPNP mode Apr 13 13:03:25 volumio volumio[887]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1120,"duration":171,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4358 Kbps","isStreaming":false,"title":"Perfect Sense, Pt. II","artist":"Roger Waters","album":"Amused To Death","uri":"http://192.168.1.141:57645/proxy/qobuz/7C3138DB1A7530786FDAC49C0B1FDDDA.flac?proxy=false","trackType":"qobuz"} Apr 13 13:03:25 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::syncState stateService pause Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:25 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 13:03:25 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::stPlaybackTimer Apr 13 13:03:25 volumio volumio[887]: info: ControllerMpd::pushState Apr 13 13:03:25 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 13 13:03:25 volumio volumio[887]: verbose: In UPNP mode Apr 13 13:03:25 volumio volumio[887]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1120,"duration":171,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4358 Kbps","isStreaming":false,"title":"Perfect Sense, Pt. II","artist":"Roger Waters","album":"Amused To Death","uri":"http://192.168.1.141:57645/proxy/qobuz/7C3138DB1A7530786FDAC49C0B1FDDDA.flac?proxy=false","trackType":"qobuz"} Apr 13 13:03:25 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::syncState stateService pause Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:25 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::stPlaybackTimer Apr 13 13:03:25 volumio volumio[887]: info: ControllerMpd::pushState Apr 13 13:03:25 volumio volumio[887]: info: CoreCommandRouter::servicePushState Apr 13 13:03:25 volumio volumio[887]: verbose: In UPNP mode Apr 13 13:03:25 volumio volumio[887]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1120,"duration":171,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4358 Kbps","isStreaming":false,"title":"Perfect Sense, Pt. II","artist":"Roger Waters","album":"Amused To Death","uri":"http://192.168.1.141:57645/proxy/qobuz/7C3138DB1A7530786FDAC49C0B1FDDDA.flac?proxy=false","trackType":"qobuz"} Apr 13 13:03:25 volumio volumio[887]: verbose: CURRENT POSITION 0 Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::syncState stateService pause Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::pushState Apr 13 13:03:25 volumio volumio[887]: info: CoreCommandRouter::volumioPushState Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::stPlaybackTimer Apr 13 13:03:25 volumio volumio[887]: info: ------------------------------ 21ms Apr 13 13:03:25 volumio volumio[887]: info: ------------------------------ 20ms Apr 13 13:03:25 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:25 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:25 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:25 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:25 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue Apr 13 13:03:25 volumio volumio[887]: info: CoreStateMachine::getQueue Apr 13 13:03:25 volumio volumio[887]: info: CorePlayQueue::getQueue Apr 13 13:03:25 volumio volumio[887]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 13 13:03:25 volumio go-librespot[1287]: time="2025-04-13T13:03:25+02:00" level=error msg="did not receive last pong from dealer, 30s passed" Apr 13 13:03:25 volumio go-librespot[1287]: time="2025-04-13T13:03:25+02:00" level=error msg="failed receiving dealer message" error="failed to get reader: received close frame: status = StatusServiceRestart and reason = \"\"" Apr 13 13:03:25 volumio go-librespot[1287]: time="2025-04-13T13:03:25+02:00" level=debug msg="renewing login5 access token" Apr 13 13:03:26 volumio go-librespot[1287]: time="2025-04-13T13:03:26+02:00" level=debug msg="authenticated as iesus_80" Apr 13 13:03:26 volumio go-librespot[1287]: time="2025-04-13T13:03:26+02:00" level=debug msg="re-established dealer connection" Apr 13 13:03:26 volumio go-librespot[1287]: time="2025-04-13T13:03:26+02:00" level=debug msg="received connection id: MGFlNWU5NjItNWIyNy00M2ZkLThkYzctZTNmNTI5MTAyMzY4K2RlYWxlcit0Y3A6Ly8wYWNiZGE2NS5pcC5ndWMzLnNwb3RpZnkubmV0OjU3MDArMDU4QkVCRDVCRjA1RjIxNTU0ODNGNEU3NDdCMThFOURCRTJCMzYxNEE2MjUwMTM2RDlGODY5QTkzOUQ1MDA3MQ==" Apr 13 13:03:26 volumio go-librespot[1287]: time="2025-04-13T13:03:26+02:00" level=debug msg="put connect state because NEW_DEVICE" Apr 13 13:03:31 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 13:03:31 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 13:03:31 volumio volumio[887]: info: Discovery: Getting this device information Apr 13 13:03:31 volumio volumio[887]: info: CoreCommandRouter::volumioGetState Apr 13 13:03:31 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 13:03:31 volumio volumio[887]: verbose: New Socket.io Connection to 192.168.1.142:3000 from 192.168.1.141 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Apr 13 13:03:31 volumio volumio[887]: info: CoreCommandRouter::volumioGetState Apr 13 13:03:31 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 13 13:03:31 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 13 13:03:33 volumio sudo[27228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 13:03:33 volumio sudo[27228]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 13:03:33 volumio sudo[27228]: pam_unix(sudo:session): session closed for user root Apr 13 13:03:33 volumio sudo[27231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 13:03:33 volumio sudo[27231]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 13:03:33 volumio sudo[27231]: pam_unix(sudo:session): session closed for user root Apr 13 13:03:33 volumio volumio[887]: verbose: New Socket.io Connection to 192.168.1.142 from 192.168.1.141 UA: Mozilla/5.0 (Linux; Android 14; SM-G991B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.38 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Apr 13 13:03:33 volumio sudo[27235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 13:03:33 volumio sudo[27235]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 13:03:33 volumio sudo[27235]: pam_unix(sudo:session): session closed for user root Apr 13 13:03:33 volumio sudo[27238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 13:03:33 volumio sudo[27238]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 13:03:33 volumio sudo[27238]: pam_unix(sudo:session): session closed for user root Apr 13 13:03:33 volumio volumio[887]: verbose: New Socket.io Connection to 192.168.1.142 from 192.168.1.141 UA: Mozilla/5.0 (Linux; Android 14; SM-G991B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.38 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Apr 13 13:03:33 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::volumioGetState Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 13:03:34 volumio volumio[887]: info: Received Get System Info Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 13:03:34 volumio volumio[887]: info: Discovery: Getting this device information Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::volumioGetState Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::volumioGetState Apr 13 13:03:34 volumio volumio[887]: info: Listing playlists Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 13 13:03:34 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 13 13:03:35 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 13 13:03:35 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 13:03:35 volumio volumio[887]: info: Received Get System Info Apr 13 13:03:35 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 13:03:35 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 13:03:35 volumio volumio[887]: info: Discovery: Getting this device information Apr 13 13:03:35 volumio volumio[887]: info: CoreCommandRouter::volumioGetState Apr 13 13:03:35 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 13:03:37 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 13:03:37 volumio volumio[887]: info: Received Get System Info Apr 13 13:03:37 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 13:03:37 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 13:03:37 volumio volumio[887]: info: Discovery: Getting this device information Apr 13 13:03:37 volumio volumio[887]: info: CoreCommandRouter::volumioGetState Apr 13 13:03:37 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 13:03:38 volumio volumio[887]: info: Retrieving Cloud Streaming UI Apr 13 13:03:38 volumio volumio[887]: info: Getting Tidal Cloud Configuration Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 13:03:38 volumio volumio[887]: info: Getting Qobuz Cloud Configuration Apr 13 13:03:38 volumio volumio[887]: info: Asking plugin for UI Config Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 13:03:38 volumio volumio[887]: info: Getting Spotify Cloud Configuration Apr 13 13:03:38 volumio volumio[887]: info: Asking plugin for UI Config Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 13:03:38 volumio volumio[887]: info: Saving Spotify Acccount Apr 13 13:03:38 volumio volumio[887]: info: Got Tidal Cloud Configuration Apr 13 13:03:38 volumio volumio[887]: info: Got it Apr 13 13:03:38 volumio volumio[887]: info: Got it Apr 13 13:03:38 volumio volumio[887]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 13:03:38 volumio volumio[887]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 13:03:38 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 13 13:03:41 volumio volumio[887]: info: Disabling MyMusic plugin upnp Apr 13 13:03:41 volumio sudo[27245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 13 13:03:41 volumio sudo[27245]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 13:03:41 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 13 13:03:41 volumio volumio[887]: error: Upnp client error: Error: This socket has been ended by the other party Apr 13 13:03:41 volumio volumio[887]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/onecall?appid=5796abbde9106b7da4febfae8c44c232&lat=37.2203&lon=-3.5931: Error: Response error: 401 - Unauthorized Apr 13 13:03:41 volumio volumio[887]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Apr 13 13:03:41 volumio volumio[887]: at runMicrotasks () Apr 13 13:03:41 volumio volumio[887]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 13 13:03:41 volumio volumio[887]: at async Promise.all (index 0) Apr 13 13:03:41 volumio volumio[887]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Apr 13 13:03:41 volumio volumio[887]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Apr 13 13:03:41 volumio volumio[887]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Apr 13 13:03:41 volumio volumio[887]: info: [now-playing] Fetching API key... Apr 13 13:03:41 volumio volumio[887]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/weather?appid=5796abbde9106b7da4febfae8c44c232&lat=37.2203&lon=-3.5931: Error: Response error: 401 - Unauthorized Apr 13 13:03:41 volumio volumio[887]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Apr 13 13:03:41 volumio volumio[887]: at runMicrotasks () Apr 13 13:03:41 volumio volumio[887]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 13 13:03:41 volumio volumio[887]: at async Promise.all (index 1) Apr 13 13:03:42 volumio volumio[887]: info: [now-playing] OpenWeatherMap API key obtained. Apr 13 13:03:42 volumio volumio[887]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/onecall?appid=5796abbde9106b7da4febfae8c44c232&lat=37.2203&lon=-3.5931: Error: Response error: 401 - Unauthorized Apr 13 13:03:42 volumio volumio[887]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Apr 13 13:03:42 volumio volumio[887]: at runMicrotasks () Apr 13 13:03:42 volumio volumio[887]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 13 13:03:42 volumio volumio[887]: at async Promise.all (index 0) Apr 13 13:03:42 volumio volumio[887]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Apr 13 13:03:42 volumio volumio[887]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Apr 13 13:03:42 volumio volumio[887]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Apr 13 13:03:42 volumio volumio[887]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not fetch weather: Response error: 401 - Unauthorized Apr 13 13:03:42 volumio volumio[887]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:114:19) Apr 13 13:03:42 volumio volumio[887]: at runMicrotasks () Apr 13 13:03:42 volumio volumio[887]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 13 13:03:42 volumio volumio[887]: at async Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:115:28) Apr 13 13:03:42 volumio volumio[887]: (node:887) UnhandledPromiseRejectionWarning: Error: Response error: 401 - Unauthorized Apr 13 13:03:42 volumio volumio[887]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Apr 13 13:03:42 volumio volumio[887]: at runMicrotasks () Apr 13 13:03:42 volumio volumio[887]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 13 13:03:42 volumio volumio[887]: at async Promise.all (index 0) Apr 13 13:03:42 volumio volumio[887]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Apr 13 13:03:42 volumio volumio[887]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Apr 13 13:03:42 volumio volumio[887]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Apr 13 13:03:42 volumio volumio[887]: (node:887) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 24) Apr 13 13:03:42 volumio volumio[887]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/weather?appid=5796abbde9106b7da4febfae8c44c232&lat=37.2203&lon=-3.5931: Error: Response error: 401 - Unauthorized Apr 13 13:03:42 volumio volumio[887]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Apr 13 13:03:42 volumio volumio[887]: at runMicrotasks () Apr 13 13:03:42 volumio volumio[887]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 13 13:03:42 volumio volumio[887]: at async Promise.all (index 1) Apr 13 13:03:42 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 13:03:43 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 13 13:03:46 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 13:03:46 volumio volumio[887]: info: Enabling MyMusic plugin upnp Apr 13 13:03:46 volumio volumio[887]: info: Enabling plugin upnp Apr 13 13:03:46 volumio volumio[887]: info: Loading plugin "upnp"... Apr 13 13:03:46 volumio volumio[887]: info: [1744542226679] Starting Upmpd Daemon Apr 13 13:03:46 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 13 13:03:46 volumio volumio[887]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 13:03:46 volumio volumio[887]: Error: listen EADDRINUSE: address already in use :::6599 Apr 13 13:03:46 volumio volumio[887]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Apr 13 13:03:46 volumio volumio[887]: at listenInCluster (net.js:1366:12) Apr 13 13:03:46 volumio volumio[887]: at Server.listen (net.js:1452:7) Apr 13 13:03:46 volumio volumio[887]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Apr 13 13:03:46 volumio volumio[887]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Apr 13 13:03:46 volumio volumio[887]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 13 13:03:46 volumio volumio[887]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 13 13:03:46 volumio volumio[887]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 13 13:03:46 volumio volumio[887]: code: 'EADDRINUSE', Apr 13 13:03:46 volumio volumio[887]: errno: -98, Apr 13 13:03:46 volumio volumio[887]: syscall: 'listen', Apr 13 13:03:46 volumio volumio[887]: address: '::', Apr 13 13:03:46 volumio volumio[887]: port: 6599 Apr 13 13:03:46 volumio volumio[887]: } Apr 13 13:03:46 volumio volumio[887]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 13:03:47 volumio sudo[27311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-13 13:02 Apr 13 13:03:47 volumio sudo[27311]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"