-- Logs begin at Wed 2024-10-09 16:21:06 UTC, end at Wed 2024-10-09 16:37:07 UTC. -- Oct 09 16:36:03 one-dac go-librespot[1008]: time="2024-10-09T16:36:03Z" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Oct 09 16:36:03 one-dac go-librespot[1008]: time="2024-10-09T16:36:03Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1176" Oct 09 16:36:03 one-dac go-librespot[1008]: time="2024-10-09T16:36:03Z" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Oct 09 16:36:03 one-dac go-librespot[1008]: time="2024-10-09T16:36:03Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Oct 09 16:36:17 one-dac go-librespot[1008]: time="2024-10-09T16:36:17Z" level=debug msg="handling skip_next player command from 69c310344bda2b813cfbf448a52ccfb391d89ddc" Oct 09 16:36:17 one-dac go-librespot[1008]: time="2024-10-09T16:36:17Z" level=debug msg="loading track (paused: true, position: 0ms)" uri="spotify:track:66dWnNlR3czCOFhAIB2stt" Oct 09 16:36:17 one-dac go-librespot[1008]: time="2024-10-09T16:36:17Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Oct 09 16:36:17 one-dac go-librespot[1008]: time="2024-10-09T16:36:17Z" level=trace msg="emitting websocket event: will_play" Oct 09 16:36:17 one-dac volumio[743]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:66dWnNlR3czCOFhAIB2stt","play_origin":"search"}} Oct 09 16:36:17 one-dac go-librespot[1008]: time="2024-10-09T16:36:17Z" level=debug msg="selected format OGG_VORBIS_320 (cbb364f177a287f6e982baa41143202181c8d732)" uri="spotify:track:66dWnNlR3czCOFhAIB2stt" Oct 09 16:36:17 one-dac go-librespot[1008]: time="2024-10-09T16:36:17Z" level=debug msg="requested aes key for file cbb364f177a287f6e982baa41143202181c8d732, gid: 66dWnNlR3czCOFhAIB2stt" Oct 09 16:36:18 one-dac go-librespot[1008]: time="2024-10-09T16:36:18Z" level=debug msg="fetched first chunk of 25, total size is 12883952 bytes" uri="spotify:track:66dWnNlR3czCOFhAIB2stt" Oct 09 16:36:18 one-dac go-librespot[1008]: time="2024-10-09T16:36:18Z" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:66dWnNlR3czCOFhAIB2stt" Oct 09 16:36:18 one-dac go-librespot[1008]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:143:(_snd_pcm_volumioswitch_open_target_pcm) PCM Volumio ALSA Switch Plugin failed to open the switcher target pcm volumioLocalPlayback Oct 09 16:36:18 one-dac go-librespot[1008]: time="2024-10-09T16:36:18Z" level=warning msg="failed handling dealer request" error="failed skipping to next track: failed loading current track (advance to spotify:track:66dWnNlR3czCOFhAIB2stt): failed setting stream for spotify:track:66dWnNlR3czCOFhAIB2stt: ALSA error at snd_pcm_open: Device or resource busy" Oct 09 16:36:18 one-dac go-librespot[1008]: time="2024-10-09T16:36:18Z" level=debug msg="fetched chunk 3/24, size: 524288" uri="spotify:track:66dWnNlR3czCOFhAIB2stt" Oct 09 16:36:18 one-dac go-librespot[1008]: time="2024-10-09T16:36:18Z" level=debug msg="fetched chunk 1/24, size: 524288" uri="spotify:track:66dWnNlR3czCOFhAIB2stt" Oct 09 16:36:18 one-dac go-librespot[1008]: time="2024-10-09T16:36:18Z" level=debug msg="fetched chunk 2/24, size: 524288" uri="spotify:track:66dWnNlR3czCOFhAIB2stt" Oct 09 16:36:21 one-dac go-librespot[1008]: time="2024-10-09T16:36:21Z" level=debug msg="handling resume player command from 69c310344bda2b813cfbf448a52ccfb391d89ddc" Oct 09 16:36:21 one-dac go-librespot[1008]: time="2024-10-09T16:36:21Z" level=debug msg="resume track at 0ms" Oct 09 16:36:21 one-dac go-librespot[1008]: time="2024-10-09T16:36:21Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Oct 09 16:36:21 one-dac go-librespot[1008]: time="2024-10-09T16:36:21Z" level=trace msg="scheduling prefetch in 299s" Oct 09 16:36:21 one-dac go-librespot[1008]: time="2024-10-09T16:36:21Z" level=debug msg="sending successful reply for dealer request" Oct 09 16:36:21 one-dac go-librespot[1008]: time="2024-10-09T16:36:21Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Oct 09 16:36:21 one-dac go-librespot[1008]: time="2024-10-09T16:36:21Z" level=trace msg="emitting websocket event: playing" Oct 09 16:36:21 one-dac volumio[743]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:66dWnNlR3czCOFhAIB2stt","play_origin":"search"}} Oct 09 16:36:21 one-dac volumio[743]: SPOTIFY: PUSH STATE SPOTIFY Oct 09 16:36:21 one-dac volumio[743]: SPOTIFY: {"status":"play","service":"spop","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"spotify","seek":11000,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Oct 09 16:36:21 one-dac volumio[743]: info: CoreCommandRouter::servicePushState Oct 09 16:36:21 one-dac volumio[743]: info: CoreStateMachine::pushState Oct 09 16:36:21 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 16:36:21 one-dac volumio[743]: info: CoreCommandRouter::volumioPushState Oct 09 16:36:21 one-dac volumio[743]: info: MRS: Pushing multiroomSync output update for this device Oct 09 16:36:21 one-dac volumio[743]: info: MRS: Pushing multiroomSync output Oct 09 16:36:21 one-dac volumio[743]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Oct 09 16:36:21 one-dac volumio[743]: SPOTIFY: SPOTIFY VOLUME 86 Oct 09 16:36:21 one-dac volumio[743]: SPOTIFY: VOLUMIO VOLUME 85 Oct 09 16:36:21 one-dac volumio[743]: SPOTIFY: DELTA VOLUME ENOUGH: false Oct 09 16:36:22 one-dac volumio[743]: SPOTIFY: PUSH STATE SPOTIFY Oct 09 16:36:22 one-dac volumio[743]: SPOTIFY: {"status":"play","service":"spop","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"spotify","seek":11000,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Oct 09 16:36:22 one-dac volumio[743]: info: CoreCommandRouter::servicePushState Oct 09 16:36:22 one-dac volumio[743]: info: CoreStateMachine::pushState Oct 09 16:36:22 one-dac volumio[743]: info: CoreCommandRouter::volumioPushState Oct 09 16:36:22 one-dac volumio[743]: info: MRS: Pushing multiroomSync output update for this device Oct 09 16:36:22 one-dac volumio[743]: info: MRS: Pushing multiroomSync output Oct 09 16:36:22 one-dac volumio[743]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Oct 09 16:36:22 one-dac volumio[743]: SPOTIFY: SPOTIFY VOLUME 86 Oct 09 16:36:22 one-dac volumio[743]: SPOTIFY: VOLUMIO VOLUME 85 Oct 09 16:36:22 one-dac volumio[743]: SPOTIFY: DELTA VOLUME ENOUGH: false Oct 09 16:36:29 one-dac go-librespot[1008]: time="2024-10-09T16:36:29Z" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Oct 09 16:36:29 one-dac go-librespot[1008]: time="2024-10-09T16:36:29Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 340" Oct 09 16:36:29 one-dac go-librespot[1008]: time="2024-10-09T16:36:29Z" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Oct 09 16:36:29 one-dac go-librespot[1008]: time="2024-10-09T16:36:29Z" level=debug msg="put connect state inactive" Oct 09 16:36:29 one-dac go-librespot[1008]: time="2024-10-09T16:36:29Z" level=trace msg="emitting websocket event: inactive" Oct 09 16:36:29 one-dac go-librespot[1008]: time="2024-10-09T16:36:29Z" level=trace msg="emitting websocket event: stopped" Oct 09 16:36:29 one-dac volumio[743]: SPOTIFY: received: {"type":"inactive","data":null} Oct 09 16:36:29 one-dac volumio[743]: error: Failed to decode event: inactive Oct 09 16:36:29 one-dac volumio[743]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":""}} Oct 09 16:36:29 one-dac volumio[743]: SPOTIFY: PUSH STATE SPOTIFY Oct 09 16:36:29 one-dac volumio[743]: SPOTIFY: {"status":"stop","service":"spop","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"spotify","seek":18000,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Oct 09 16:36:29 one-dac volumio[743]: info: CoreCommandRouter::servicePushState Oct 09 16:36:29 one-dac volumio[743]: info: CoreStateMachine::pushState Oct 09 16:36:29 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 16:36:29 one-dac volumio[743]: info: CoreCommandRouter::volumioPushState Oct 09 16:36:29 one-dac volumio[743]: info: MRS: Pushing multiroomSync output update for this device Oct 09 16:36:29 one-dac volumio[743]: info: MRS: Pushing multiroomSync output Oct 09 16:36:29 one-dac volumio[743]: info: CorePlayQueue::getTrack 2 Oct 09 16:36:29 one-dac volumio[743]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received spop Oct 09 16:36:29 one-dac go-librespot[1008]: time="2024-10-09T16:36:29Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1213" Oct 09 16:36:29 one-dac volumio[743]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Oct 09 16:36:29 one-dac volumio[743]: SPOTIFY: SPOTIFY VOLUME 86 Oct 09 16:36:29 one-dac volumio[743]: SPOTIFY: VOLUMIO VOLUME 85 Oct 09 16:36:29 one-dac volumio[743]: SPOTIFY: DELTA VOLUME ENOUGH: false Oct 09 16:36:29 one-dac go-librespot[1008]: time="2024-10-09T16:36:29Z" level=error msg="failed receiving dealer message" error="failed to get reader: received close frame: status = StatusGoingAway and reason = \"\"" Oct 09 16:36:29 one-dac go-librespot[1008]: time="2024-10-09T16:36:29Z" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.1.27:41472->104.199.241.202:4070: use of closed network connection" Oct 09 16:36:29 one-dac volumio[743]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 09 16:36:29 one-dac volumio[743]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 09 16:36:29 one-dac volumio[743]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 09 16:36:36 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 16:36:36 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 16:36:36 one-dac volumio[743]: info: Discovery: Getting this device information Oct 09 16:36:36 one-dac volumio[743]: info: CoreCommandRouter::volumioGetState Oct 09 16:36:36 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 16:36:36 one-dac volumio[743]: verbose: New Socket.io Connection to 192.168.1.27:3000 from 192.168.1.20 UA: Dart/3.4 (dart:io) Total Clients: 9 Oct 09 16:36:36 one-dac volumio[743]: info: CoreCommandRouter::volumioGetState Oct 09 16:36:36 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 09 16:36:36 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 09 16:36:37 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 16:36:37 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 16:36:37 one-dac volumio[743]: info: Discovery: Getting this device information Oct 09 16:36:37 one-dac volumio[743]: info: CoreCommandRouter::volumioGetState Oct 09 16:36:37 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 16:36:37 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 16:36:37 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 16:36:37 one-dac volumio[743]: info: Discovery: Getting this device information Oct 09 16:36:37 one-dac volumio[743]: info: CoreCommandRouter::volumioGetState Oct 09 16:36:37 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 16:36:40 one-dac sudo[4341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 09 16:36:40 one-dac sudo[4341]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 16:36:40 one-dac sudo[4341]: pam_unix(sudo:session): session closed for user root Oct 09 16:36:40 one-dac sudo[4344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 09 16:36:40 one-dac sudo[4344]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 16:36:40 one-dac sudo[4344]: pam_unix(sudo:session): session closed for user root Oct 09 16:36:40 one-dac volumio[743]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 14; SM-S901E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.81 Mobile Safari/537.36 Total Clients: 10 Oct 09 16:36:40 one-dac sudo[4347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 09 16:36:40 one-dac sudo[4347]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 16:36:40 one-dac sudo[4347]: pam_unix(sudo:session): session closed for user root Oct 09 16:36:40 one-dac sudo[4350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 09 16:36:40 one-dac sudo[4350]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 16:36:40 one-dac sudo[4350]: pam_unix(sudo:session): session closed for user root Oct 09 16:36:40 one-dac volumio[743]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 14; SM-S901E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.81 Mobile Safari/537.36 Total Clients: 11 Oct 09 16:36:40 one-dac volumio[743]: info: CoreCommandRouter::volumioGetState Oct 09 16:36:41 one-dac ntpd[645]: Soliciting pool server 2401:5f80:5001:1f::31f Oct 09 16:36:41 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 09 16:36:41 one-dac volumio[743]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 09 16:36:41 one-dac volumio[743]: info: Listing playlists Oct 09 16:36:41 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 09 16:36:41 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 09 16:36:41 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 09 16:36:41 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 09 16:36:42 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 09 16:36:44 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 09 16:36:49 one-dac volumio[743]: info: Retrieving Cloud Streaming UI Oct 09 16:36:49 one-dac volumio[743]: info: Getting Tidal Cloud Configuration Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 09 16:36:49 one-dac volumio[743]: info: Getting Qobuz Cloud Configuration Oct 09 16:36:49 one-dac volumio[743]: info: Asking plugin for UI Config Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 09 16:36:49 one-dac volumio[743]: info: Getting Spotify Cloud Configuration Oct 09 16:36:49 one-dac volumio[743]: info: Asking plugin for UI Config Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 09 16:36:49 one-dac volumio[743]: info: Saving Spotify Acccount Oct 09 16:36:49 one-dac volumio[743]: info: Got it Oct 09 16:36:49 one-dac volumio[743]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 09 16:36:49 one-dac volumio[743]: info: Got Tidal Cloud Configuration Oct 09 16:36:49 one-dac volumio[743]: info: Got it Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::volumioGetBrowseSources Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 09 16:36:49 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 09 16:36:53 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 09 16:36:57 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 09 16:36:59 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 09 16:36:59 one-dac volumio[743]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 09 16:36:59 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 09 16:36:59 one-dac volumio[743]: info: Received Get System Version Oct 09 16:36:59 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 09 16:36:59 one-dac volumio[743]: info: Received Get System Info Oct 09 16:36:59 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 16:36:59 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 16:36:59 one-dac volumio[743]: info: Discovery: Getting this device information Oct 09 16:36:59 one-dac volumio[743]: info: CoreCommandRouter::volumioGetState Oct 09 16:36:59 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 16:37:01 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 09 16:37:04 one-dac volumio[743]: info: Disabling MyMusic plugin upnp Oct 09 16:37:04 one-dac sudo[4355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 09 16:37:04 one-dac sudo[4355]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 16:37:04 one-dac systemd[1]: Stopping UPnP Renderer front-end to MPD... Oct 09 16:37:04 one-dac volumio[743]: error: Upnp client error: Error: This socket has been ended by the other party Oct 09 16:37:04 one-dac volumio[743]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 09 16:37:05 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 09 16:37:05 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 16:37:05 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 16:37:05 one-dac volumio[743]: info: Discovery: Getting this device information Oct 09 16:37:05 one-dac volumio[743]: info: CoreCommandRouter::volumioGetState Oct 09 16:37:05 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 16:37:06 one-dac volumio[743]: info: Enabling MyMusic plugin upnp Oct 09 16:37:06 one-dac volumio[743]: info: Enabling plugin upnp Oct 09 16:37:06 one-dac volumio[743]: info: Loading plugin "upnp"... Oct 09 16:37:06 one-dac volumio[743]: info: [1728491826945] Starting Upmpd Daemon Oct 09 16:37:06 one-dac volumio[743]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 16:37:06 one-dac volumio[743]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 16:37:06 one-dac volumio[743]: Error: listen EADDRINUSE: address already in use :::6599 Oct 09 16:37:06 one-dac volumio[743]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Oct 09 16:37:06 one-dac volumio[743]: at listenInCluster (net.js:1366:12) Oct 09 16:37:06 one-dac volumio[743]: at Server.listen (net.js:1452:7) Oct 09 16:37:06 one-dac volumio[743]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Oct 09 16:37:06 one-dac volumio[743]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Oct 09 16:37:06 one-dac volumio[743]: at Promise._successFn (/volumio/app/pluginmanager.js:1841:19) Oct 09 16:37:06 one-dac volumio[743]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 09 16:37:06 one-dac volumio[743]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Oct 09 16:37:06 one-dac volumio[743]: code: 'EADDRINUSE', Oct 09 16:37:06 one-dac volumio[743]: errno: -98, Oct 09 16:37:06 one-dac volumio[743]: syscall: 'listen', Oct 09 16:37:06 one-dac volumio[743]: address: '::', Oct 09 16:37:06 one-dac volumio[743]: port: 6599 Oct 09 16:37:06 one-dac volumio[743]: } Oct 09 16:37:06 one-dac volumio[743]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 16:37:07 one-dac sudo[4368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-09 16:36 Oct 09 16:37:07 one-dac sudo[4368]: 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="c87c6e2b1ae33dc5801986cbcbe970898b92e7b4" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="b949d6001d7e656b4668f31c119d2247cdf45158" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 30 Mar 2023 05:45:03 PM CEST" VOLUMIO_VERSION="3.449" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6428d8e2c06e98483f5c5d77e8f01989"