-- Logs begin at Thu 2025-02-20 16:38:58 CET, end at Thu 2025-02-20 16:45:39 CET. -- Feb 20 16:44:01 audio-2 volumio[1113]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 20 16:44:01 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 20 16:44:01 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 20 16:44:01 audio-2 sudo[2759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 20 16:44:01 audio-2 sudo[2759]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:01 audio-2 sudo[2766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 20 16:44:01 audio-2 sudo[2773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 20 16:44:01 audio-2 sudo[2759]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:01 audio-2 sudo[2766]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:01 audio-2 sudo[2773]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:01 audio-2 sudo[2766]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:01 audio-2 sudo[2773]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:01 audio-2 sudo[2786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 20 16:44:01 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 20 16:44:01 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 20 16:44:01 audio-2 sudo[2786]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:01 audio-2 sudo[2797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 20 16:44:01 audio-2 sudo[2811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 20 16:44:01 audio-2 sudo[2786]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:01 audio-2 sudo[2811]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:01 audio-2 sudo[2797]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:01 audio-2 sudo[2797]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:01 audio-2 sudo[2811]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:01 audio-2 sudo[2830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 20 16:44:01 audio-2 sudo[2830]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:02 audio-2 sudo[2830]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:04 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 20 16:44:11 audio-2 ntpd[1213]: ntpd exiting on signal 15 (Terminated) Feb 20 16:44:11 audio-2 ntpd[1213]: 185.51.192.61 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 185.244.24.36 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 194.87.82.162 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 164.92.156.55 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 162.159.200.1 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 193.111.32.123 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 195.242.98.57 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 45.90.187.8 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 systemd[1]: Stopping Network Time Service... Feb 20 16:44:11 audio-2 ntpd[1213]: 178.239.19.61 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 178.239.19.58 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 185.51.192.63 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 95.85.21.89 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 178.239.19.63 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 5.255.124.190 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 185.51.192.62 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 ntpd[1213]: 94.198.159.16 local addr 192.168.136.77 -> Feb 20 16:44:11 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:11 audio-2 systemd[1]: ntp.service: Succeeded. Feb 20 16:44:11 audio-2 systemd[1]: Stopped Network Time Service. Feb 20 16:44:11 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 20 16:44:11 audio-2 systemd[1]: Starting Network Time Service... Feb 20 16:44:11 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:11 audio-2 ntpd[2895]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 20 16:44:11 audio-2 ntpd[2895]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 20 16:44:11 audio-2 systemd[1]: Started Network Time Service. Feb 20 16:44:11 audio-2 ntpd[2901]: proto: precision = 0.583 usec (-21) Feb 20 16:44:11 audio-2 ntpd[2901]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 20 16:44:11 audio-2 ntpd[2901]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 20 16:44:11 audio-2 ntpd[2901]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 786 days ago Feb 20 16:44:11 audio-2 ntpd[2901]: Listen and drop on 0 v6wildcard [::]:123 Feb 20 16:44:11 audio-2 ntpd[2901]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 20 16:44:11 audio-2 ntpd[2901]: Listen normally on 2 lo 127.0.0.1:123 Feb 20 16:44:11 audio-2 ntpd[2901]: Listen normally on 3 eth0 192.168.136.77:123 Feb 20 16:44:11 audio-2 ntpd[2901]: Listen normally on 4 wlan0 192.168.136.79:123 Feb 20 16:44:11 audio-2 ntpd[2901]: Listening on routing socket on fd #21 for interface updates Feb 20 16:44:11 audio-2 ntpd[2901]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 20 16:44:11 audio-2 ntpd[2901]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 20 16:44:11 audio-2 ntpd[2901]: ntpd exiting on signal 15 (Terminated) Feb 20 16:44:11 audio-2 systemd[1]: Stopping Network Time Service... Feb 20 16:44:11 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:11 audio-2 systemd[1]: ntp.service: Succeeded. Feb 20 16:44:11 audio-2 systemd[1]: Stopped Network Time Service. Feb 20 16:44:11 audio-2 systemd[1]: Starting Network Time Service... Feb 20 16:44:11 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 20 16:44:11 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:11 audio-2 ntpd[2936]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 20 16:44:11 audio-2 ntpd[2936]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 20 16:44:11 audio-2 systemd[1]: Started Network Time Service. Feb 20 16:44:11 audio-2 ntpd[2942]: proto: precision = 0.583 usec (-21) Feb 20 16:44:11 audio-2 ntpd[2942]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 20 16:44:11 audio-2 ntpd[2942]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 20 16:44:11 audio-2 ntpd[2942]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 786 days ago Feb 20 16:44:11 audio-2 ntpd[2942]: Listen and drop on 0 v6wildcard [::]:123 Feb 20 16:44:11 audio-2 ntpd[2942]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 20 16:44:11 audio-2 ntpd[2942]: Listen normally on 2 lo 127.0.0.1:123 Feb 20 16:44:11 audio-2 ntpd[2942]: Listen normally on 3 eth0 192.168.136.77:123 Feb 20 16:44:11 audio-2 ntpd[2942]: Listen normally on 4 wlan0 192.168.136.79:123 Feb 20 16:44:11 audio-2 ntpd[2942]: Listening on routing socket on fd #21 for interface updates Feb 20 16:44:11 audio-2 ntpd[2942]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 20 16:44:11 audio-2 ntpd[2942]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 20 16:44:11 audio-2 ntpd[2942]: ntpd exiting on signal 15 (Terminated) Feb 20 16:44:11 audio-2 systemd[1]: Stopping Network Time Service... Feb 20 16:44:11 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:12 audio-2 systemd[1]: ntp.service: Succeeded. Feb 20 16:44:12 audio-2 systemd[1]: Stopped Network Time Service. Feb 20 16:44:12 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 20 16:44:12 audio-2 systemd[1]: Starting Network Time Service... Feb 20 16:44:12 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:12 audio-2 ntpd[2977]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 20 16:44:12 audio-2 ntpd[2977]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 20 16:44:12 audio-2 systemd[1]: Started Network Time Service. Feb 20 16:44:12 audio-2 ntpd[2983]: proto: precision = 0.583 usec (-21) Feb 20 16:44:12 audio-2 ntpd[2983]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 20 16:44:12 audio-2 ntpd[2983]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 20 16:44:12 audio-2 ntpd[2983]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 786 days ago Feb 20 16:44:12 audio-2 ntpd[2983]: Listen and drop on 0 v6wildcard [::]:123 Feb 20 16:44:12 audio-2 ntpd[2983]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 20 16:44:12 audio-2 ntpd[2983]: Listen normally on 2 lo 127.0.0.1:123 Feb 20 16:44:12 audio-2 ntpd[2983]: Listen normally on 3 eth0 192.168.136.77:123 Feb 20 16:44:12 audio-2 ntpd[2983]: Listen normally on 4 wlan0 192.168.136.79:123 Feb 20 16:44:12 audio-2 ntpd[2983]: Listening on routing socket on fd #21 for interface updates Feb 20 16:44:12 audio-2 ntpd[2983]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 20 16:44:12 audio-2 ntpd[2983]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 20 16:44:12 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 20 16:44:12 audio-2 volumio[1113]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 20 16:44:12 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 20 16:44:12 audio-2 volumio[1113]: info: Received Get System Version Feb 20 16:44:12 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 20 16:44:12 audio-2 volumio[1113]: info: Received Get System Info Feb 20 16:44:12 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 20 16:44:12 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 20 16:44:12 audio-2 volumio[1113]: info: Discovery: Getting this device information Feb 20 16:44:12 audio-2 volumio[1113]: info: CoreCommandRouter::volumioGetState Feb 20 16:44:12 audio-2 volumio[1113]: info: CorePlayQueue::getTrack 0 Feb 20 16:44:12 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 20 16:44:13 audio-2 ntpd[2983]: Soliciting pool server 193.123.56.220 Feb 20 16:44:13 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 20 16:44:13 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 20 16:44:13 audio-2 volumio[1113]: info: Discovery: Getting this device information Feb 20 16:44:13 audio-2 volumio[1113]: info: CoreCommandRouter::volumioGetState Feb 20 16:44:13 audio-2 volumio[1113]: info: CorePlayQueue::getTrack 0 Feb 20 16:44:13 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 20 16:44:14 audio-2 ntpd[2983]: Soliciting pool server 162.159.200.123 Feb 20 16:44:14 audio-2 ntpd[2983]: Soliciting pool server 178.239.19.59 Feb 20 16:44:15 audio-2 ntpd[2983]: Soliciting pool server 191.96.11.154 Feb 20 16:44:15 audio-2 ntpd[2983]: Soliciting pool server 5.255.99.180 Feb 20 16:44:15 audio-2 ntpd[2983]: Soliciting pool server 195.35.113.80 Feb 20 16:44:16 audio-2 ntpd[2983]: Soliciting pool server 149.143.87.82 Feb 20 16:44:16 audio-2 ntpd[2983]: Soliciting pool server 45.138.55.61 Feb 20 16:44:16 audio-2 ntpd[2983]: Soliciting pool server 193.36.132.241 Feb 20 16:44:17 audio-2 ntpd[2983]: Soliciting pool server 178.239.19.56 Feb 20 16:44:17 audio-2 ntpd[2983]: Soliciting pool server 45.83.205.227 Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 20 16:44:17 audio-2 volumio[1113]: info: Retrieving Cloud Streaming UI Feb 20 16:44:17 audio-2 volumio[1113]: info: Getting Tidal Cloud Configuration Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 20 16:44:17 audio-2 volumio[1113]: info: Getting Qobuz Cloud Configuration Feb 20 16:44:17 audio-2 volumio[1113]: info: Asking plugin for UI Config Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 20 16:44:17 audio-2 volumio[1113]: info: Getting Spotify Cloud Configuration Feb 20 16:44:17 audio-2 volumio[1113]: info: Asking plugin for UI Config Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 20 16:44:17 audio-2 volumio[1113]: info: Saving Spotify Acccount Feb 20 16:44:17 audio-2 volumio[1113]: info: Got it Feb 20 16:44:17 audio-2 volumio[1113]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 20 16:44:17 audio-2 volumio[1113]: info: Got Tidal Cloud Configuration Feb 20 16:44:17 audio-2 volumio[1113]: info: Got it Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::volumioGetBrowseSources Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::volumioGetBrowseSources Feb 20 16:44:17 audio-2 volumio[1113]: info: CoreCommandRouter::volumioGetBrowseSources Feb 20 16:44:18 audio-2 ntpd[2983]: Soliciting pool server 178.239.19.63 Feb 20 16:44:18 audio-2 ntpd[2983]: Soliciting pool server 83.137.149.135 Feb 20 16:44:18 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:44:18 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 20 16:44:19 audio-2 ntpd[2983]: Soliciting pool server 45.91.209.64 Feb 20 16:44:19 audio-2 ntpd[2983]: Soliciting pool server 2a00:d78:0:712:94:198:159:15 Feb 20 16:44:22 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:44:26 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:44:30 audio-2 volumio[1113]: info: Disabling MyMusic plugin multiroom Feb 20 16:44:30 audio-2 volumio[1113]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface multiroom Feb 20 16:44:30 audio-2 volumio[1113]: info: Disabling plugin multiroom Feb 20 16:44:30 audio-2 volumio[1113]: info: Preparing to generate the ALSA configuration file Feb 20 16:44:30 audio-2 volumio[1113]: info: Asound.conf file written Feb 20 16:44:30 audio-2 sudo[3021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 20 16:44:30 audio-2 sudo[3021]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:30 audio-2 sudo[3021]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:30 audio-2 volumio[1113]: xcb_connection_has_error() returned true Feb 20 16:44:30 audio-2 volumio[1113]: info: Output device has changed, restarting MPD Feb 20 16:44:30 audio-2 volumio[1113]: info: Output device has changed, restarting Shairport Sync Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 20 16:44:30 audio-2 sudo[3033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 20 16:44:30 audio-2 sudo[3036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 20 16:44:30 audio-2 sudo[3033]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:30 audio-2 sudo[3036]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:30 audio-2 sudo[3033]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:30 audio-2 volumio[1113]: xcb_connection_has_error() returned true Feb 20 16:44:30 audio-2 volumio[1113]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 20 16:44:30 audio-2 systemd[1]: Stopping Music Player Daemon... Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 vtcs[1918]: [2025-02-20 16:44:30.513] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Feb 20 16:44:30 audio-2 vtcs[1918]: [2025-02-20 16:44:30.514] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=4 errorno=104 error=Connection reset by peer Feb 20 16:44:30 audio-2 vtcs[1918]: [2025-02-20 16:44:30.514] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Feb 20 16:44:30 audio-2 sudo[3055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 20 16:44:30 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:30 audio-2 sudo[3055]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:30 audio-2 systemd[1]: mpd.service: Succeeded. Feb 20 16:44:30 audio-2 systemd[1]: Stopped Music Player Daemon. Feb 20 16:44:30 audio-2 volumio[1113]: info: MPD Permissions set Feb 20 16:44:30 audio-2 systemd[1]: Starting Music Player Daemon... Feb 20 16:44:30 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 sudo[3061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 20 16:44:30 audio-2 systemd[1]: Stopping Volumio Tidal Connect Service... Feb 20 16:44:30 audio-2 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 20 16:44:30 audio-2 systemd[1]: vtcs.service: Succeeded. Feb 20 16:44:30 audio-2 systemd[1]: Stopped Volumio Tidal Connect Service. Feb 20 16:44:30 audio-2 sudo[3061]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:30 audio-2 sudo[3055]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 20 16:44:30 audio-2 sudo[3061]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 20 16:44:30 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:30 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:30 audio-2 volumio[1113]: info: Starting Shairport Sync Feb 20 16:44:30 audio-2 sudo[3064]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 20 16:44:30 audio-2 sudo[3064]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:30 audio-2 sudo[3085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 20 16:44:30 audio-2 sudo[3064]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:30 audio-2 sudo[3085]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:30 audio-2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 20 16:44:30 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:30 audio-2 systemd[1]: shairport-sync.service: Succeeded. Feb 20 16:44:30 audio-2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 20 16:44:30 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 20 16:44:30 audio-2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 20 16:44:30 audio-2 sudo[3085]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:30 audio-2 volumio[1113]: info: Shairport-Sync Started Feb 20 16:44:31 audio-2 mpd[3105]: Feb 20 16:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 20 16:44:31 audio-2 systemd[1]: Started Music Player Daemon. Feb 20 16:44:31 audio-2 sudo[3036]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:31 audio-2 volumio[1113]: error: updateQueue error: null Feb 20 16:44:33 audio-2 volumio[1113]: info: TidalConnect service stoped! Feb 20 16:44:33 audio-2 volumio[1113]: info: TidalConnect service stoped! Feb 20 16:44:33 audio-2 volumio[1113]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 20 16:44:33 audio-2 volumio[1113]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 20 16:44:33 audio-2 sudo[3124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 20 16:44:33 audio-2 sudo[3124]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:33 audio-2 systemd[1]: Started Volumio Tidal Connect Service. Feb 20 16:44:33 audio-2 sudo[3124]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:33 audio-2 volumio[1113]: info: Executing endpoint tc_getconfig Feb 20 16:44:33 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 20 16:44:33 audio-2 vtcs[3130]: STARTING TidalConnect services, version: 1.4.0.34 Feb 20 16:44:33 audio-2 vtcs[3130]: STARTED TidalConnect services. Feb 20 16:44:33 audio-2 volumio[1113]: info: Executing endpoint tc_connect Feb 20 16:44:33 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 20 16:44:33 audio-2 volumio[1113]: info: Connecting to TidalConnect Feb 20 16:44:33 audio-2 volumio[1113]: info: CoreCommandRouter::servicePushState Feb 20 16:44:33 audio-2 volumio[1113]: info: CoreStateMachine::pushState Feb 20 16:44:33 audio-2 volumio[1113]: info: CorePlayQueue::getTrack 0 Feb 20 16:44:33 audio-2 volumio[1113]: info: CoreCommandRouter::volumioPushState Feb 20 16:44:33 audio-2 volumio[1113]: info: MRS: Pushing multiroomSync output update for this device Feb 20 16:44:33 audio-2 volumio[1113]: info: MRS: Pushing multiroomSync output Feb 20 16:44:33 audio-2 volumio[1113]: info: CorePlayQueue::getTrack 0 Feb 20 16:44:33 audio-2 volumio[1113]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Feb 20 16:44:33 audio-2 volumio[1113]: info: CoreCommandRouter::servicePushState Feb 20 16:44:33 audio-2 volumio[1113]: info: CoreStateMachine::pushState Feb 20 16:44:33 audio-2 volumio[1113]: info: CorePlayQueue::getTrack 0 Feb 20 16:44:33 audio-2 volumio[1113]: info: CoreCommandRouter::volumioPushState Feb 20 16:44:33 audio-2 volumio[1113]: info: MRS: Pushing multiroomSync output update for this device Feb 20 16:44:33 audio-2 volumio[1113]: info: MRS: Pushing multiroomSync output Feb 20 16:44:33 audio-2 volumio[1113]: info: CorePlayQueue::getTrack 0 Feb 20 16:44:33 audio-2 volumio[1113]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Feb 20 16:44:34 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:44:36 audio-2 volumio[1113]: info: TidalConnect service started! Feb 20 16:44:37 audio-2 volumio[1113]: info: Disabling MyMusic plugin cd_controller Feb 20 16:44:37 audio-2 volumio[1113]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service cd_controller Feb 20 16:44:37 audio-2 volumio[1113]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Feb 20 16:44:37 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 20 16:44:37 audio-2 volumio[1113]: Cannot find translation for source Spotify Feb 20 16:44:37 audio-2 volumio[1113]: info: Stopping UDEV Watcher for CD Feb 20 16:44:37 audio-2 volumio[1113]: info: Disabling plugin cd_controller Feb 20 16:44:38 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:44:40 audio-2 volumio[1113]: info: Disabling MyMusic plugin smart_inputs Feb 20 16:44:40 audio-2 volumio[1113]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service smart_inputs Feb 20 16:44:40 audio-2 volumio[1113]: info: Removeing all smart Inputs Feb 20 16:44:40 audio-2 volumio[1113]: info: Disabling plugin smart_inputs Feb 20 16:44:41 audio-2 volumio[1113]: info: Disabling MyMusic plugin tidalconnect Feb 20 16:44:41 audio-2 volumio[1113]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service tidalconnect Feb 20 16:44:41 audio-2 vtcs[3130]: [2025-02-20 16:44:41.944] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Feb 20 16:44:41 audio-2 vtcs[3130]: [2025-02-20 16:44:41.944] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Feb 20 16:44:41 audio-2 volumio[1113]: info: Disabling plugin tidalconnect Feb 20 16:44:41 audio-2 sudo[3167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 20 16:44:41 audio-2 sudo[3167]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:44:41 audio-2 systemd[1]: Stopping Volumio Tidal Connect Service... Feb 20 16:44:41 audio-2 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 20 16:44:41 audio-2 systemd[1]: vtcs.service: Succeeded. Feb 20 16:44:42 audio-2 systemd[1]: Stopped Volumio Tidal Connect Service. Feb 20 16:44:42 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:44:42 audio-2 sudo[3167]: pam_unix(sudo:session): session closed for user root Feb 20 16:44:42 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:44:43 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 20 16:44:43 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 20 16:44:43 audio-2 volumio[1113]: info: Discovery: Getting this device information Feb 20 16:44:43 audio-2 volumio[1113]: info: CoreCommandRouter::volumioGetState Feb 20 16:44:43 audio-2 volumio[1113]: info: CorePlayQueue::getTrack 0 Feb 20 16:44:43 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 20 16:44:45 audio-2 volumio[1113]: info: TidalConnect service stoped! Feb 20 16:44:46 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:44:50 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:44:54 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:44:58 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:02 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:06 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:10 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:13 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 20 16:45:13 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 20 16:45:13 audio-2 volumio[1113]: info: Discovery: Getting this device information Feb 20 16:45:13 audio-2 volumio[1113]: info: CoreCommandRouter::volumioGetState Feb 20 16:45:13 audio-2 volumio[1113]: info: CorePlayQueue::getTrack 0 Feb 20 16:45:13 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 20 16:45:14 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:18 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:22 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:25 audio-2 volumio[1113]: info: Disabling MyMusic plugin metavolumio Feb 20 16:45:25 audio-2 volumio[1113]: info: [MyVolumio PluginManager] Disabling and stopping plugin miscellanea metavolumio Feb 20 16:45:25 audio-2 volumio[1113]: info: Removing METAVOLUMIO REST API Endpoints Feb 20 16:45:25 audio-2 volumio[1113]: info: Removing metavolumio REST Endpoint Feb 20 16:45:25 audio-2 volumio[1113]: info: Removing getSimilarArtists REST Endpoint Feb 20 16:45:25 audio-2 volumio[1113]: info: Removing getSimilarAlbums REST Endpoint Feb 20 16:45:25 audio-2 volumio[1113]: info: Removing getSimilarTracks REST Endpoint Feb 20 16:45:25 audio-2 volumio[1113]: info: Disabling plugin metavolumio Feb 20 16:45:25 audio-2 wpa_supplicant[935]: wlan0: WPA: Group rekeying completed with e4:8d:8c:dc:04:cf [GTK=CCMP] Feb 20 16:45:26 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:30 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:33 audio-2 volumio[1113]: info: Disabling MyMusic plugin upnp Feb 20 16:45:33 audio-2 sudo[3307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Feb 20 16:45:33 audio-2 sudo[3307]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 16:45:33 audio-2 systemd[1]: Stopping UPnP Renderer front-end to MPD... Feb 20 16:45:33 audio-2 volumio[1113]: error: Upnp client error: Error: This socket has been ended by the other party Feb 20 16:45:33 audio-2 volumio[1113]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 20 16:45:34 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:38 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 20 16:45:39 audio-2 volumio[1113]: info: Enabling MyMusic plugin upnp Feb 20 16:45:39 audio-2 volumio[1113]: info: Enabling plugin upnp Feb 20 16:45:39 audio-2 volumio[1113]: info: Loading plugin "upnp"... Feb 20 16:45:39 audio-2 volumio[1113]: info: [1740066339627] Starting Upmpd Daemon Feb 20 16:45:39 audio-2 volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 20 16:45:39 audio-2 volumio[1113]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 20 16:45:39 audio-2 volumio[1113]: Error: listen EADDRINUSE: address already in use :::6599 Feb 20 16:45:39 audio-2 volumio[1113]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Feb 20 16:45:39 audio-2 volumio[1113]: at listenInCluster (net.js:1379:12) Feb 20 16:45:39 audio-2 volumio[1113]: at Server.listen (net.js:1465:7) Feb 20 16:45:39 audio-2 volumio[1113]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Feb 20 16:45:39 audio-2 volumio[1113]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Feb 20 16:45:39 audio-2 volumio[1113]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Feb 20 16:45:39 audio-2 volumio[1113]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 20 16:45:39 audio-2 volumio[1113]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Feb 20 16:45:39 audio-2 volumio[1113]: code: 'EADDRINUSE', Feb 20 16:45:39 audio-2 volumio[1113]: errno: -98, Feb 20 16:45:39 audio-2 volumio[1113]: syscall: 'listen', Feb 20 16:45:39 audio-2 volumio[1113]: address: '::', Feb 20 16:45:39 audio-2 volumio[1113]: port: 6599 Feb 20 16:45:39 audio-2 volumio[1113]: } Feb 20 16:45:39 audio-2 volumio[1113]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 20 16:45:39 audio-2 sudo[3336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-20 16:44 Feb 20 16:45:39 audio-2 sudo[3336]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:11:38 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="932fc3546f7cc8faa2b4d349036752dd"