-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2024-05-11 15:12:07 CEST. -- May 11 15:11:01 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:01+02:00" level=debug msg="handling skip_next player command from e6d5463a1ef69900e320ea03e59463d825516a8e" May 11 15:11:01 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:01+02:00" level=debug msg="skip next track" May 11 15:11:01 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:01+02:00" level=error msg="failed fetching next tracks" error="failed moving to next index 50 (page 1): failed fetching next page: invalid status code from page at radio-apollo/v3/tracks/spotify:station:track:21a1k8q3DJtsF8GorRfcL8?salt=572737&autoplay=false&count=50&isVideo=false&prev_tracks=44OuxVAGgMvw1J9jn4lFt3,6D1DHo5DDEdxmT8soscP6x,2ezF8mcfJ6CEkxbzgzkApX,3BmVELHoqjF7s3px9rW6WN,5pXui9rkf5W90DgZobuDiK,4AjE48Y6jK4phaQyGODpsA,2Hh3ETdQKrmSI3QS0hme7g,2wgBBqtX5x2UfcJItChy3H,21a1k8q3DJtsF8GorRfcL8,4WyRR7iO0hufoCKZ1kiguz,0mL82sxCRjrs3br407IdJh,7GfCJU7IMUVa5rl5DoOEOh,3azJifCSqg9fRij2yKIbWz,0HqxMCPnThJ3An1QIeIzJF,7eFrFAGSyWSspEwZwaDGyX,7ckfO3Cerf6OsNgdHBqf1b,1W7zkKgRv9mrLbfdQ8XyH3,3Sx0q69PAFb74XZyLJzq0Q,1ACA277B6f46DYCgZW8di3,5fVl28RgREvxVtGSf9OsbK,010ZkIVv6Ay5vqqHVCCiKB,2lX6fhI06mFH4maaex6cIZ,4DcsVmrZKyKWhNOKbMMMQH,6AgN8BrRPwYj2EH1QziDVN,7a1UiDLvw2yyuRPtANObXb,7uDUb37h7Xdhza1eWMkoJv,3jwQt00cvkN57H6ZR75W2K,2K7xn816oNHJZ0aVqdQsha,5IgjP7X4th6nMNDh4akUHb,0cLRpJeSYnFKhoX57Vremm,3TKakBgJaTH5INk0WhU4xP,4HwDCXsMBC7SUdp2WT4MZP,4F5kOAG106Avx0NcnBD9hf,5J0aeclzDn1pZQ6zIAMX2H,7zwn1eykZtZ5LODrf7c0tS,2i5Tv2YmhhSyyKsnT5zjHR,1ghqDkglrXPcxgRobBmLVW,7fzHQizxTqy8wTXwlrgPQQ,6EtKlIQmGPB9SX8UjDJG5s,2dHHgzDwk4BJdRwy9uXhTO,45JYEmfoWSpCA3Paut7YXE,2QqHzl5lYCYGNgvXXStx1y,4WNrx9GTx4RvdnxR6qVysR,45PkeRx1bxN0jerK9pxYTe,2KtS31kaWNHs12Q5B43Ixh,131SfRMv57LKf8xtaSt39k,6g6hQOcDSt9IR2wAMCxr2M,4GHXB0oee0BrCWJ2CMVJNe,289C9vPHlZczskHeL6K7Hy,4nyRgEqQgr44hfM8SUgsU8&minimal=true: 502" May 11 15:11:01 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:01+02:00" level=debug msg="loading track spotify:track:5fVl28RgREvxVtGSf9OsbK (paused: false, position: 0ms)" May 11 15:11:01 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:01+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" May 11 15:11:01 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:01+02:00" level=trace msg="emitting websocket event: will_play" May 11 15:11:01 rasp-volumio volumio[788]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:5fVl28RgREvxVtGSf9OsbK","play_origin":""}} May 11 15:11:01 rasp-volumio volumio[788]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:5fVl28RgREvxVtGSf9OsbK","play_origin":""}} May 11 15:11:01 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:01+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:5fVl28RgREvxVtGSf9OsbK" May 11 15:11:01 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:01+02:00" level=debug msg="requested aes key for file a55e7c98e6ec260decb8d15011bbe2ce4a5559cd, gid: 5fVl28RgREvxVtGSf9OsbK" May 11 15:11:01 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:01+02:00" level=warning msg="failed handling dealer request" error="failed loading current track (skip next): failed creating stream: failed retrieving audio key: failed retrieving aes key with code 1" May 11 15:11:03 rasp-volumio wpa_supplicant[2213]: RRM: Ignoring radio measurement request: Not RRM network May 11 15:11:05 rasp-volumio wpa_supplicant[2213]: RRM: Ignoring radio measurement request: Not RRM network May 11 15:11:05 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:05+02:00" level=debug msg="handling pause player command from e6d5463a1ef69900e320ea03e59463d825516a8e" May 11 15:11:05 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:05+02:00" level=warning msg="failed handling dealer request" error="no stream" May 11 15:11:15 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:15+02:00" level=debug msg="handling set_queue player command from e6d5463a1ef69900e320ea03e59463d825516a8e" May 11 15:11:15 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:15+02:00" level=warning msg="failed handling dealer request" error="unsupported player command: set_queue" May 11 15:11:16 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:16+02:00" level=debug msg="handling skip_next player command from e6d5463a1ef69900e320ea03e59463d825516a8e" May 11 15:11:16 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:16+02:00" level=debug msg="skip next track" May 11 15:11:16 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:16+02:00" level=error msg="failed fetching next tracks" error="failed moving to next index 50 (page 1): failed fetching next page: invalid status code from page at radio-apollo/v3/tracks/spotify:station:track:21a1k8q3DJtsF8GorRfcL8?salt=572737&autoplay=false&count=50&isVideo=false&prev_tracks=44OuxVAGgMvw1J9jn4lFt3,6D1DHo5DDEdxmT8soscP6x,2ezF8mcfJ6CEkxbzgzkApX,3BmVELHoqjF7s3px9rW6WN,5pXui9rkf5W90DgZobuDiK,4AjE48Y6jK4phaQyGODpsA,2Hh3ETdQKrmSI3QS0hme7g,2wgBBqtX5x2UfcJItChy3H,21a1k8q3DJtsF8GorRfcL8,4WyRR7iO0hufoCKZ1kiguz,0mL82sxCRjrs3br407IdJh,7GfCJU7IMUVa5rl5DoOEOh,3azJifCSqg9fRij2yKIbWz,0HqxMCPnThJ3An1QIeIzJF,7eFrFAGSyWSspEwZwaDGyX,7ckfO3Cerf6OsNgdHBqf1b,1W7zkKgRv9mrLbfdQ8XyH3,3Sx0q69PAFb74XZyLJzq0Q,1ACA277B6f46DYCgZW8di3,5fVl28RgREvxVtGSf9OsbK,010ZkIVv6Ay5vqqHVCCiKB,2lX6fhI06mFH4maaex6cIZ,4DcsVmrZKyKWhNOKbMMMQH,6AgN8BrRPwYj2EH1QziDVN,7a1UiDLvw2yyuRPtANObXb,7uDUb37h7Xdhza1eWMkoJv,3jwQt00cvkN57H6ZR75W2K,2K7xn816oNHJZ0aVqdQsha,5IgjP7X4th6nMNDh4akUHb,0cLRpJeSYnFKhoX57Vremm,3TKakBgJaTH5INk0WhU4xP,4HwDCXsMBC7SUdp2WT4MZP,4F5kOAG106Avx0NcnBD9hf,5J0aeclzDn1pZQ6zIAMX2H,7zwn1eykZtZ5LODrf7c0tS,2i5Tv2YmhhSyyKsnT5zjHR,1ghqDkglrXPcxgRobBmLVW,7fzHQizxTqy8wTXwlrgPQQ,6EtKlIQmGPB9SX8UjDJG5s,2dHHgzDwk4BJdRwy9uXhTO,45JYEmfoWSpCA3Paut7YXE,2QqHzl5lYCYGNgvXXStx1y,4WNrx9GTx4RvdnxR6qVysR,45PkeRx1bxN0jerK9pxYTe,2KtS31kaWNHs12Q5B43Ixh,131SfRMv57LKf8xtaSt39k,6g6hQOcDSt9IR2wAMCxr2M,4GHXB0oee0BrCWJ2CMVJNe,289C9vPHlZczskHeL6K7Hy,4nyRgEqQgr44hfM8SUgsU8&minimal=true: 502" May 11 15:11:16 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:16+02:00" level=debug msg="loading track spotify:track:010ZkIVv6Ay5vqqHVCCiKB (paused: false, position: 0ms)" May 11 15:11:16 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:16+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" May 11 15:11:16 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:16+02:00" level=trace msg="emitting websocket event: will_play" May 11 15:11:16 rasp-volumio volumio[788]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:010ZkIVv6Ay5vqqHVCCiKB","play_origin":""}} May 11 15:11:16 rasp-volumio volumio[788]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:010ZkIVv6Ay5vqqHVCCiKB","play_origin":""}} May 11 15:11:16 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:16+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:010ZkIVv6Ay5vqqHVCCiKB" May 11 15:11:16 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:16+02:00" level=debug msg="requested aes key for file 6e59651b1ec8b96bbf518fd9dfbd2135d3bcfb09, gid: 010ZkIVv6Ay5vqqHVCCiKB" May 11 15:11:16 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:16+02:00" level=warning msg="failed handling dealer request" error="failed loading current track (skip next): failed creating stream: failed retrieving audio key: failed retrieving aes key with code 1" May 11 15:11:17 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:17+02:00" level=debug msg="handling pause player command from e6d5463a1ef69900e320ea03e59463d825516a8e" May 11 15:11:17 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:17+02:00" level=warning msg="failed handling dealer request" error="no stream" May 11 15:11:21 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:21+02:00" level=debug msg="put connect state inactive" May 11 15:11:21 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:21+02:00" level=trace msg="emitting websocket event: inactive" May 11 15:11:21 rasp-volumio volumio[788]: SPOTIFY: received: {"type":"inactive","data":null} May 11 15:11:21 rasp-volumio volumio[788]: error: Failed to decode event: inactive May 11 15:11:21 rasp-volumio volumio[788]: SPOTIFY: received: {"type":"inactive","data":null} May 11 15:11:21 rasp-volumio volumio[788]: error: Failed to decode event: inactive May 11 15:11:28 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:28+02:00" level=debug msg="handling transfer player command from e6d5463a1ef69900e320ea03e59463d825516a8e" May 11 15:11:28 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:28+02:00" level=trace msg="fetched new page 0 with 50 items (list: 50)" May 11 15:11:28 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:28+02:00" level=error msg="failed fetching next tracks" error="failed moving to next index 50 (page 1): failed fetching next page: invalid status code from page at radio-apollo/v3/tracks/spotify:station:track:21a1k8q3DJtsF8GorRfcL8?salt=419992&autoplay=false&count=50&isVideo=false&prev_tracks=44OuxVAGgMvw1J9jn4lFt3,6D1DHo5DDEdxmT8soscP6x,2ezF8mcfJ6CEkxbzgzkApX,3BmVELHoqjF7s3px9rW6WN,5pXui9rkf5W90DgZobuDiK,4AjE48Y6jK4phaQyGODpsA,2Hh3ETdQKrmSI3QS0hme7g,2wgBBqtX5x2UfcJItChy3H,21a1k8q3DJtsF8GorRfcL8,4WyRR7iO0hufoCKZ1kiguz,0mL82sxCRjrs3br407IdJh,7GfCJU7IMUVa5rl5DoOEOh,3azJifCSqg9fRij2yKIbWz,0HqxMCPnThJ3An1QIeIzJF,7eFrFAGSyWSspEwZwaDGyX,7ckfO3Cerf6OsNgdHBqf1b,1W7zkKgRv9mrLbfdQ8XyH3,3Sx0q69PAFb74XZyLJzq0Q,1ACA277B6f46DYCgZW8di3,5fVl28RgREvxVtGSf9OsbK,010ZkIVv6Ay5vqqHVCCiKB,2lX6fhI06mFH4maaex6cIZ,4DcsVmrZKyKWhNOKbMMMQH,6AgN8BrRPwYj2EH1QziDVN,7a1UiDLvw2yyuRPtANObXb,7uDUb37h7Xdhza1eWMkoJv,3jwQt00cvkN57H6ZR75W2K,2K7xn816oNHJZ0aVqdQsha,5IgjP7X4th6nMNDh4akUHb,0cLRpJeSYnFKhoX57Vremm,3TKakBgJaTH5INk0WhU4xP,4HwDCXsMBC7SUdp2WT4MZP,4F5kOAG106Avx0NcnBD9hf,5J0aeclzDn1pZQ6zIAMX2H,7zwn1eykZtZ5LODrf7c0tS,2i5Tv2YmhhSyyKsnT5zjHR,1ghqDkglrXPcxgRobBmLVW,7fzHQizxTqy8wTXwlrgPQQ,6EtKlIQmGPB9SX8UjDJG5s,2dHHgzDwk4BJdRwy9uXhTO,45JYEmfoWSpCA3Paut7YXE,2QqHzl5lYCYGNgvXXStx1y,4WNrx9GTx4RvdnxR6qVysR,45PkeRx1bxN0jerK9pxYTe,2KtS31kaWNHs12Q5B43Ixh,131SfRMv57LKf8xtaSt39k,6g6hQOcDSt9IR2wAMCxr2M,4GHXB0oee0BrCWJ2CMVJNe,289C9vPHlZczskHeL6K7Hy,4nyRgEqQgr44hfM8SUgsU8&minimal=true: 502" May 11 15:11:28 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:28+02:00" level=debug msg="loading track spotify:track:010ZkIVv6Ay5vqqHVCCiKB (paused: false, position: 11662ms)" May 11 15:11:28 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:28+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" May 11 15:11:28 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:28+02:00" level=trace msg="emitting websocket event: will_play" May 11 15:11:28 rasp-volumio volumio[788]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:010ZkIVv6Ay5vqqHVCCiKB","play_origin":""}} May 11 15:11:28 rasp-volumio volumio[788]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:010ZkIVv6Ay5vqqHVCCiKB","play_origin":""}} May 11 15:11:28 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:28+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:010ZkIVv6Ay5vqqHVCCiKB" May 11 15:11:28 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:28+02:00" level=debug msg="requested aes key for file 6e59651b1ec8b96bbf518fd9dfbd2135d3bcfb09, gid: 010ZkIVv6Ay5vqqHVCCiKB" May 11 15:11:28 rasp-volumio go-librespot[2811]: time="2024-05-11T15:11:28+02:00" level=warning msg="failed handling dealer request" error="failed loading current track (transfer): failed creating stream: failed retrieving audio key: failed retrieving aes key with code 1" May 11 15:11:34 rasp-volumio volumio[788]: info: CoreCommandRouter::volumioPlay May 11 15:11:34 rasp-volumio volumio[788]: info: CoreStateMachine::play index undefined May 11 15:11:34 rasp-volumio volumio[788]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 15:11:34 rasp-volumio volumio[788]: info: CorePlayQueue::getTrack 0 May 11 15:11:35 rasp-volumio volumio[788]: info: CoreCommandRouter::volumioGetQueue May 11 15:11:35 rasp-volumio volumio[788]: info: CoreStateMachine::getQueue May 11 15:11:35 rasp-volumio volumio[788]: info: CorePlayQueue::getQueue May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 11 15:11:38 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 11 15:11:59 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 15:12:03 rasp-volumio volumio[788]: info: Retrieving Cloud Streaming UI May 11 15:12:03 rasp-volumio volumio[788]: info: Getting Tidal Cloud Configuration May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 15:12:03 rasp-volumio volumio[788]: info: Getting Qobuz Cloud Configuration May 11 15:12:03 rasp-volumio volumio[788]: info: Asking plugin for UI Config May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 15:12:03 rasp-volumio volumio[788]: info: Getting Spotify Cloud Configuration May 11 15:12:03 rasp-volumio volumio[788]: info: Asking plugin for UI Config May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 15:12:03 rasp-volumio volumio[788]: info: Saving Spotify Acccount May 11 15:12:03 rasp-volumio volumio[788]: info: Got Tidal Cloud Configuration May 11 15:12:03 rasp-volumio volumio[788]: info: Got it May 11 15:12:03 rasp-volumio volumio[788]: info: Got it May 11 15:12:03 rasp-volumio volumio[788]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 15:12:03 rasp-volumio volumio[788]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::volumioGetBrowseSources May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::volumioGetBrowseSources May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::volumioGetBrowseSources May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 11 15:12:03 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 11 15:12:06 rasp-volumio volumio[788]: info: Disabling MyMusic plugin upnp May 11 15:12:06 rasp-volumio sudo[2876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service May 11 15:12:06 rasp-volumio sudo[2876]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 15:12:06 rasp-volumio volumio[788]: error: Upnp client error: Error: This socket has been ended by the other party May 11 15:12:06 rasp-volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... May 11 15:12:07 rasp-volumio volumio[788]: info: Enabling MyMusic plugin upnp May 11 15:12:07 rasp-volumio volumio[788]: info: Enabling plugin upnp May 11 15:12:07 rasp-volumio volumio[788]: info: Loading plugin "upnp"... May 11 15:12:07 rasp-volumio volumio[788]: info: [1715433127515] Starting Upmpd Daemon May 11 15:12:07 rasp-volumio volumio[788]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 11 15:12:07 rasp-volumio volumio[788]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 15:12:07 rasp-volumio volumio[788]: Error: listen EADDRINUSE: address already in use :::6599 May 11 15:12:07 rasp-volumio volumio[788]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) May 11 15:12:07 rasp-volumio volumio[788]: at listenInCluster (net.js:1366:12) May 11 15:12:07 rasp-volumio volumio[788]: at Server.listen (net.js:1452:7) May 11 15:12:07 rasp-volumio volumio[788]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) May 11 15:12:07 rasp-volumio volumio[788]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) May 11 15:12:07 rasp-volumio volumio[788]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 11 15:12:07 rasp-volumio volumio[788]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 11 15:12:07 rasp-volumio volumio[788]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { May 11 15:12:07 rasp-volumio volumio[788]: code: 'EADDRINUSE', May 11 15:12:07 rasp-volumio volumio[788]: errno: -98, May 11 15:12:07 rasp-volumio volumio[788]: syscall: 'listen', May 11 15:12:07 rasp-volumio volumio[788]: address: '::', May 11 15:12:07 rasp-volumio volumio[788]: port: 6599 May 11 15:12:07 rasp-volumio volumio[788]: } May 11 15:12:07 rasp-volumio volumio[788]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 15:12:07 rasp-volumio sudo[2887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-11 15:11 May 11 15:12:07 rasp-volumio sudo[2887]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"