-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2024-03-29 18:51:55 CET. -- Mar 29 18:51:11 kchenradio volumio[1020]: ..............................................++++ Mar 29 18:51:11 kchenradio volumio[1020]: e is 65537 (0x010001) Mar 29 18:51:11 kchenradio volumio[1020]: writing RSA key Mar 29 18:51:12 kchenradio volumio[889]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Mar 29 18:51:12 kchenradio volumio[889]: info: CoreCommandRouter::volumioGetState Mar 29 18:51:12 kchenradio volumio[889]: info: CorePlayQueue::getTrack 0 Mar 29 18:51:12 kchenradio volumio[889]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 Mar 29 18:51:12 kchenradio volumio[889]: SPOTIFY: SPOTIFY VOLUME undefined Mar 29 18:51:12 kchenradio volumio[889]: SPOTIFY: VOLUMIO VOLUME 20 Mar 29 18:51:12 kchenradio volumio[889]: info: Aligning Spotify Volume to Volumio Volume Mar 29 18:51:12 kchenradio volumio[889]: info: CoreCommandRouter::volumioGetState Mar 29 18:51:12 kchenradio volumio[889]: info: CorePlayQueue::getTrack 0 Mar 29 18:51:12 kchenradio volumio[889]: info: Setting Spotify Volume from Volumio: 20 Mar 29 18:51:12 kchenradio ntpd[648]: Soliciting pool server 2001:1640:3::3 Mar 29 18:51:13 kchenradio ntpd[648]: Soliciting pool server 185.11.138.90 Mar 29 18:51:13 kchenradio volumio[889]: SPOTIFY: SETTING SPOTIFY VOLUME 20 Mar 29 18:51:13 kchenradio volumio[889]: info: Sending Spotify command with payload to local API: /player/volume Mar 29 18:51:13 kchenradio volumio[889]: error: Failed to send command to Spotify local API: /player/volume: Error: Internal Server Error Mar 29 18:51:14 kchenradio volumio[889]: error: MyVolumio Plugin failed to start in a timely fashion Mar 29 18:51:14 kchenradio volumio[889]: info: BOOT COMPLETED Mar 29 18:51:14 kchenradio volumio[889]: [Metrics] CommandRouter: 64s 563.81ms Mar 29 18:51:14 kchenradio volumio[889]: info: CoreCommandRouter::volumiosetStartupVolume Mar 29 18:51:14 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 18:51:14 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:14 kchenradio volumio[889]: info: CoreCommandRouter::Close All Modals sent Mar 29 18:51:14 kchenradio volumio[889]: info: CoreCommandRouter::Close All Modals sent Mar 29 18:51:14 kchenradio ntpd[648]: Soliciting pool server 178.63.52.50 Mar 29 18:51:15 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 29 18:51:15 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 29 18:51:15 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 29 18:51:15 kchenradio ntpd[648]: Soliciting pool server 144.76.0.164 Mar 29 18:51:16 kchenradio go-librespot[1157]: time="2024-03-29T18:51:16+01:00" level=debug msg="authenticated as 31kxjlze7pdqm2w2h3xba2j5d5i4" Mar 29 18:51:16 kchenradio ntpd[648]: Soliciting pool server 85.215.189.120 Mar 29 18:51:18 kchenradio ntpd[648]: Soliciting pool server 194.163.182.21 Mar 29 18:51:21 kchenradio go-librespot[1157]: time="2024-03-29T18:51:21+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Mar 29 18:51:21 kchenradio go-librespot[1157]: time="2024-03-29T18:51:21+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 29 18:51:21 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 29 18:51:21 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:21 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 29 18:51:23 kchenradio ntpd[648]: Soliciting pool server 129.250.35.251 Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 29 18:51:23 kchenradio volumio[889]: info: Adding plugin bluetooth to MyMusic Plugins Mar 29 18:51:23 kchenradio volumio[889]: info: Adding plugin multiroom to MyMusic Plugins Mar 29 18:51:23 kchenradio volumio[889]: info: Adding plugin metavolumio to MyMusic Plugins Mar 29 18:51:23 kchenradio volumio[889]: info: Adding plugin cd_controller to MyMusic Plugins Mar 29 18:51:23 kchenradio volumio[889]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 29 18:51:23 kchenradio volumio[889]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 29 18:51:23 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 29 18:51:25 kchenradio volumio[889]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 29 18:51:25 kchenradio volumio[889]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 29 18:51:25 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:25 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:25 kchenradio volumio[889]: info: Starting MyVolumio Remote Streaming Endpoints Mar 29 18:51:25 kchenradio volumio[889]: info: MyVolumio login type: Token Mar 29 18:51:25 kchenradio volumio[889]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 29 18:51:25 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 29 18:51:26 kchenradio go-librespot[1157]: time="2024-03-29T18:51:26+01:00" level=debug msg="dealer connection opened" Mar 29 18:51:26 kchenradio go-librespot[1157]: time="2024-03-29T18:51:26+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 29 18:51:26 kchenradio go-librespot[1157]: time="2024-03-29T18:51:26+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 29 18:51:26 kchenradio go-librespot[1157]: time="2024-03-29T18:51:26+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 29 18:51:26 kchenradio go-librespot[1157]: time="2024-03-29T18:51:26+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 29 18:51:26 kchenradio go-librespot[1157]: time="2024-03-29T18:51:26+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Mar 29 18:51:26 kchenradio go-librespot[1157]: time="2024-03-29T18:51:26+01:00" level=debug msg="received connection id: OWEzMDIyNDctODg2Yy00OWJkLTgwZDQtNmRjYjY0NWUwODU4K2RlYWxlcit0Y3A6Ly9nZXc0LWRlYWxlci1hLXQzcTkuZ2V3NC5zcG90aWZ5Lm5ldDo1NzAwKzkzM0IwQ0MyOEZCQzUwM0FBQjNGNzI3RDkzOEQ2MzEzRTkzQUU5RTNGODJFMzI2RkFDN0VFMDRFNzU2RTUxREI=" Mar 29 18:51:27 kchenradio volumio[889]: info: Starting Streaming Service Transparent Proxy Mar 29 18:51:27 kchenradio volumio[889]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 29 18:51:27 kchenradio volumio[889]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 29 18:51:27 kchenradio volumio[889]: info: Streaming services startup Mar 29 18:51:27 kchenradio volumio[889]: info: Starting Streaming Daemon Mar 29 18:51:27 kchenradio sudo[1427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 29 18:51:27 kchenradio sudo[1427]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:27 kchenradio volumio[889]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 29 18:51:27 kchenradio sudo[1427]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:27 kchenradio volumio[889]: info: Spotify volume: 100 Mar 29 18:51:27 kchenradio volumio[889]: error: Cannot start Volumio Streaming Daemon Mar 29 18:51:27 kchenradio volumio[889]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 29 18:51:27 kchenradio volumio[889]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 29 18:51:27 kchenradio volumio[889]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Mar 29 18:51:27 kchenradio volumio[889]: info: PLUGIN onReboot : networkfs Mar 29 18:51:27 kchenradio volumio[889]: info: PLUGIN onReboot : touch_display Mar 29 18:51:27 kchenradio sudo[1435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Mar 29 18:51:27 kchenradio sudo[1435]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:27 kchenradio sudo[1435]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:27 kchenradio sudo[1437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Mar 29 18:51:27 kchenradio sudo[1437]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:27 kchenradio systemd[1]: Stopping Volumio Kiosk... Mar 29 18:51:27 kchenradio volumio[889]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Mar 29 18:51:27 kchenradio sudo[1447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reboot Mar 29 18:51:27 kchenradio sudo[1447]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:27 kchenradio systemd-logind[526]: System is rebooting. Mar 29 18:51:27 kchenradio sudo[1447]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:27 kchenradio volumio[889]: info: Rebooting Mar 29 18:51:27 kchenradio systemd[1]: Stopped target Graphical Interface. Mar 29 18:51:27 kchenradio systemd[1]: Stopped target Timers. Mar 29 18:51:27 kchenradio systemd[1]: apt-daily-upgrade.timer: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Daily apt upgrade and clean activities. Mar 29 18:51:27 kchenradio systemd[1]: systemd-rfkill.socket: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch. Mar 29 18:51:27 kchenradio systemd[1]: Stopped target Bluetooth. Mar 29 18:51:27 kchenradio bluetoothd[933]: Terminating Mar 29 18:51:27 kchenradio systemd[1]: Stopping Bluetooth service... Mar 29 18:51:27 kchenradio systemd[1]: Stopping go-librespot Daemon... Mar 29 18:51:27 kchenradio systemd[1]: Removed slice system-bthelper.slice. Mar 29 18:51:27 kchenradio systemd[1]: man-db.timer: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Daily man-db regeneration. Mar 29 18:51:27 kchenradio systemd[1]: Stopped target RPC Port Mapper. Mar 29 18:51:27 kchenradio systemd[1]: apt-daily.timer: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Daily apt download activities. Mar 29 18:51:27 kchenradio bluetoothd[933]: Stopping SDP server Mar 29 18:51:27 kchenradio bluetoothd[933]: Exit Mar 29 18:51:27 kchenradio systemd[1]: Stopped target System Time Synchronized. Mar 29 18:51:27 kchenradio volumio[889]: info: Connection to go-librespot Websocket closed Mar 29 18:51:27 kchenradio systemd[1]: systemd-tmpfiles-clean.timer: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Daily Cleanup of Temporary Directories. Mar 29 18:51:27 kchenradio systemd[1]: Starting Show Plymouth Reboot Screen... Mar 29 18:51:27 kchenradio systemd[1]: Unmounting RPC Pipe File System... Mar 29 18:51:27 kchenradio systemd[1]: Stopped target Multi-User System. Mar 29 18:51:27 kchenradio systemd[1]: Stopped target Login Prompts. Mar 29 18:51:27 kchenradio systemd[1]: Stopping Permit User Sessions... Mar 29 18:51:27 kchenradio systemd[1]: Stopping Login Service... Mar 29 18:51:27 kchenradio ntpd[648]: ntpd exiting on signal 15 (Terminated) Mar 29 18:51:27 kchenradio ntpd[648]: 194.59.207.235 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio systemd[1]: Stopping Network Time Service... Mar 29 18:51:27 kchenradio ntpd[648]: 217.197.91.176 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 213.209.109.44 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 31.209.85.243 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 162.159.200.1 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 176.9.166.35 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 3.121.254.221 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 23.88.7.139 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 185.11.138.90 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 178.63.52.50 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 144.76.0.164 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 85.215.189.120 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio ntpd[648]: 194.163.182.21 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 29 18:51:27 kchenradio ntpd[648]: 129.250.35.251 local addr 192.168.178.57 -> Mar 29 18:51:27 kchenradio systemd[1]: Stopping LSB: Brings up/down network automatically... Mar 29 18:51:27 kchenradio systemd[1]: Stopping Volumio Log Rotation Service... Mar 29 18:51:27 kchenradio systemd[1]: Stopping UPnP Renderer front-end to MPD... Mar 29 18:51:27 kchenradio systemd[1]: Stopping Samba SMB Daemon... Mar 29 18:51:27 kchenradio systemd[1]: Stopping LSB: set CPUFreq kernel parameters... Mar 29 18:51:27 kchenradio systemd[1]: Stopping volumio-remote-updater.service... Mar 29 18:51:27 kchenradio systemd[1]: Stopping triggerhappy global hotkey daemon... Mar 29 18:51:27 kchenradio systemd[1]: Stopping Music Player Daemon... Mar 29 18:51:27 kchenradio systemd[1]: rc-local.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped /etc/rc.local Compatibility. Mar 29 18:51:27 kchenradio systemd[1]: Starting Turns off Raspberry Pi display backlight on shutdown/reboot... Mar 29 18:51:27 kchenradio systemd[1]: volumiologrotate.service: Main process exited, code=killed, status=15/TERM Mar 29 18:51:27 kchenradio systemd[1]: volumiologrotate.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Volumio Log Rotation Service. Mar 29 18:51:27 kchenradio systemd[1]: volumio-remote-updater.service: Main process exited, code=killed, status=15/TERM Mar 29 18:51:27 kchenradio systemd[1]: volumio-remote-updater.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped volumio-remote-updater.service. Mar 29 18:51:27 kchenradio systemd[1]: ntp.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Network Time Service. Mar 29 18:51:27 kchenradio systemd[1]: smbd.service: Main process exited, code=killed, status=15/TERM Mar 29 18:51:27 kchenradio systemd[1]: smbd.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Samba SMB Daemon. Mar 29 18:51:27 kchenradio systemd[1]: bluetooth.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Bluetooth service. Mar 29 18:51:27 kchenradio systemd[1]: upmpdcli.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped UPnP Renderer front-end to MPD. Mar 29 18:51:27 kchenradio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Mar 29 18:51:27 kchenradio systemd[1]: go-librespot-daemon.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped go-librespot Daemon. Mar 29 18:51:27 kchenradio systemd[1]: shairport-sync.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 29 18:51:27 kchenradio systemd[1]: systemd-logind.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Login Service. Mar 29 18:51:27 kchenradio systemd[1]: mpd.service: Succeeded. Mar 29 18:51:27 kchenradio systemd[1]: Stopped Music Player Daemon. Mar 29 18:51:28 kchenradio systemd[1]: run-rpc_pipefs.mount: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Unmounted RPC Pipe File System. Mar 29 18:51:28 kchenradio systemd[1]: systemd-user-sessions.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped Permit User Sessions. Mar 29 18:51:28 kchenradio systemd[1]: rpi-display-backlight.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Started Turns off Raspberry Pi display backlight on shutdown/reboot. Mar 29 18:51:28 kchenradio systemd[1]: Started Show Plymouth Reboot Screen. Mar 29 18:51:28 kchenradio systemd[1]: Received SIGRTMIN+20 from PID 1458 (plymouthd). Mar 29 18:51:28 kchenradio avahi-daemon[547]: Got SIGTERM, quitting. Mar 29 18:51:28 kchenradio avahi-daemon[547]: Leaving mDNS multicast group on interface wlan1.IPv4 with address 192.168.178.61. Mar 29 18:51:28 kchenradio avahi-daemon[547]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.57. Mar 29 18:51:28 kchenradio avahi-daemon[547]: avahi-daemon 0.7 exiting. Mar 29 18:51:28 kchenradio systemd[1]: Stopping Avahi mDNS/DNS-SD Stack... Mar 29 18:51:28 kchenradio volumio[889]: info: Discovery: Browse raised the following error Error: dns service error: unknown Mar 29 18:51:28 kchenradio volumio[889]: error: Discovery: Advertisement error: Error: dns service error: unknown Mar 29 18:51:28 kchenradio volumio[889]: error: Discovery: advertisement error: Error: dns service error: unknown Mar 29 18:51:28 kchenradio volumio[889]: info: Discovery: Advertisement raised the following error Error: dns service error: unknown Mar 29 18:51:28 kchenradio systemd[1]: Stopped target Sound Card. Mar 29 18:51:28 kchenradio ifplugd(eth0)[657]: Exiting. Mar 29 18:51:28 kchenradio systemd[1]: Stopping Save/Restore Sound Card State... Mar 29 18:51:28 kchenradio winbindd[838]: [2024/03/29 18:51:28.134445, 0] ../source3/winbindd/winbindd.c:244(winbindd_sig_term_handler) Mar 29 18:51:28 kchenradio systemd[1]: Stopping Samba Winbind Daemon... Mar 29 18:51:28 kchenradio winbindd[829]: [2024/03/29 18:51:28.134445, 0] ../source3/winbindd/winbindd.c:244(winbindd_sig_term_handler) Mar 29 18:51:28 kchenradio systemd[1]: avahi-daemon.service: Succeeded. Mar 29 18:51:28 kchenradio winbindd[829]: Got sig[15] terminate (is_parent=1) Mar 29 18:51:28 kchenradio systemd[1]: Stopped Avahi mDNS/DNS-SD Stack. Mar 29 18:51:28 kchenradio winbindd[838]: Got sig[15] terminate (is_parent=0) Mar 29 18:51:28 kchenradio systemd[1]: cpufrequtils.service: Succeeded. Mar 29 18:51:28 kchenradio winbindd[845]: [2024/03/29 18:51:28.138292, 0] ../source3/winbindd/winbindd.c:244(winbindd_sig_term_handler) Mar 29 18:51:28 kchenradio systemd[1]: Stopped LSB: set CPUFreq kernel parameters. Mar 29 18:51:28 kchenradio winbindd[844]: [2024/03/29 18:51:28.138338, 0] ../source3/winbindd/winbindd.c:244(winbindd_sig_term_handler) Mar 29 18:51:28 kchenradio winbindd[844]: Got sig[15] terminate (is_parent=0) Mar 29 18:51:28 kchenradio winbindd[845]: Got sig[15] terminate (is_parent=0) Mar 29 18:51:28 kchenradio systemd[1]: Stopping LSB: Load kernel modules needed to enable cpufreq scaling... Mar 29 18:51:28 kchenradio systemd[1]: winbind.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped Samba Winbind Daemon. Mar 29 18:51:28 kchenradio nmbd[632]: [2024/03/29 18:51:28.187937, 0] ../source3/nmbd/nmbd.c:58(terminate) Mar 29 18:51:28 kchenradio nmbd[632]: Got SIGTERM: going down... Mar 29 18:51:28 kchenradio systemd[1]: Stopping Samba NMB Daemon... Mar 29 18:51:28 kchenradio systemd[1]: nmbd.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped Samba NMB Daemon. Mar 29 18:51:28 kchenradio systemd[1]: alsa-restore.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped Save/Restore Sound Card State. Mar 29 18:51:28 kchenradio ifplugd[1460]: Network Interface Plugging Daemon...stop eth0...done. Mar 29 18:51:28 kchenradio systemd[1]: ifplugd.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped LSB: Brings up/down network automatically. Mar 29 18:51:28 kchenradio systemd[1]: Stopping Manage Sound Card State (restore and store)... Mar 29 18:51:28 kchenradio systemd[1]: Stopped target Network is Online. Mar 29 18:51:28 kchenradio systemd[1]: Stopped target Network. Mar 29 18:51:28 kchenradio systemd[1]: Stopping ifup for wlan0... Mar 29 18:51:28 kchenradio systemd[1]: Stopping WPA supplicant... Mar 29 18:51:28 kchenradio systemd[1]: Stopping Raise network interfaces... Mar 29 18:51:28 kchenradio systemd[1]: wpa_supplicant.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped WPA supplicant. Mar 29 18:51:28 kchenradio alsactl[538]: alsactl daemon stopped Mar 29 18:51:28 kchenradio systemd[1]: alsa-state.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped Manage Sound Card State (restore and store). Mar 29 18:51:28 kchenradio systemd[1]: triggerhappy.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped triggerhappy global hotkey daemon. Mar 29 18:51:28 kchenradio dhcpcd[782]: wlan0: pid 1500 deleted IP address 192.168.178.57/24 Mar 29 18:51:28 kchenradio dhcpcd[782]: wlan0: deleting route to 192.168.178.0/24 Mar 29 18:51:28 kchenradio dhcpcd[782]: wlan0: deleting default route via 192.168.178.1 Mar 29 18:51:28 kchenradio systemd[1]: Stopping D-Bus System Message Bus... Mar 29 18:51:28 kchenradio systemd[1]: dbus.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped D-Bus System Message Bus. Mar 29 18:51:28 kchenradio systemd[1]: loadcpufreq.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped LSB: Load kernel modules needed to enable cpufreq scaling. Mar 29 18:51:28 kchenradio wpa_supplicant[766]: wlan0: CTRL-EVENT-DISCONNECTED bssid=f0:b0:14:80:5b:1c reason=0 Mar 29 18:51:28 kchenradio systemd[1]: Stopped target Remote File Systems. Mar 29 18:51:28 kchenradio systemd[1]: Stopped target Remote File Systems (Pre). Mar 29 18:51:28 kchenradio systemd[1]: Stopped target NFS client services. Mar 29 18:51:28 kchenradio systemd[1]: ifup@wlan0.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped ifup for wlan0. Mar 29 18:51:28 kchenradio dhcpcd[782]: wlan0: rebinding lease of 192.168.178.57 Mar 29 18:51:28 kchenradio systemd[1]: networking.service: Succeeded. Mar 29 18:51:28 kchenradio systemd[1]: Stopped Raise network interfaces. Mar 29 18:51:28 kchenradio dhcpcd[782]: wlan0: bpf_send: Network is down Mar 29 18:51:28 kchenradio dhcpcd[782]: arp_read: wlan0: Network is down Mar 29 18:51:28 kchenradio dhcpcd[782]: dhcp_readbpf: wlan0: Network is down Mar 29 18:51:28 kchenradio dhcpcd[782]: wlan0: carrier lost Mar 29 18:51:28 kchenradio volumio[889]: STREAMING PROXY: Starting server on port 3245 Mar 29 18:51:28 kchenradio volumio[889]: Node JS runtime: 14 Mar 29 18:51:30 kchenradio sudo[1576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/reboot Mar 29 18:51:30 kchenradio sudo[1576]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:30 kchenradio systemd[1]: Starting Turns off Raspberry Pi display backlight on shutdown/reboot... Mar 29 18:51:30 kchenradio sudo[1576]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:30 kchenradio systemd[1]: rpi-display-backlight.service: Succeeded. Mar 29 18:51:30 kchenradio systemd[1]: Started Turns off Raspberry Pi display backlight on shutdown/reboot. Mar 29 18:51:30 kchenradio volumio[889]: info: Initializing connection to go-librespot Websocket Mar 29 18:51:33 kchenradio volumio[889]: info: Discovery: Started advertising with name: KüchenRadio Mar 29 18:51:37 kchenradio volumio[889]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 29 18:51:38 kchenradio volumio[889]: error: Discovery: Generic error: Error: dns service error: unknown Mar 29 18:51:38 kchenradio volumio[889]: info: Discovery: Started advertising with name: KüchenRadio Mar 29 18:51:40 kchenradio volumio[889]: info: Initializing connection to go-librespot Websocket Mar 29 18:51:40 kchenradio volumio[889]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 29 18:51:40 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 29 18:51:40 kchenradio volumio[889]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Mar 29 18:51:40 kchenradio volumio[889]: info: CoreCommandRouter::volumioGetState Mar 29 18:51:40 kchenradio volumio[889]: info: CorePlayQueue::getTrack 0 Mar 29 18:51:42 kchenradio volumio[889]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 29 18:51:43 kchenradio volumio[889]: error: Discovery: Generic error: Error: dns service error: unknown Mar 29 18:51:43 kchenradio volumio[889]: info: Discovery: Started advertising with name: KüchenRadio Mar 29 18:51:43 kchenradio volumio[889]: info: Initializing connection to go-librespot Websocket Mar 29 18:51:45 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 18:51:45 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 18:51:45 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 29 18:51:45 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 29 18:51:45 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 29 18:51:45 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 29 18:51:45 kchenradio volumio[889]: info: CoreCommandRouter::volumioGetBrowseSources Mar 29 18:51:45 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 29 18:51:47 kchenradio volumio[889]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 29 18:51:47 kchenradio volumio[889]: info: MyVolumio token set successfully Mar 29 18:51:47 kchenradio volumio[889]: info: MYVOLUMIO: Adding device Mar 29 18:51:47 kchenradio volumio[889]: info: MYVOLUMIO: Evaluating Server Mar 29 18:51:48 kchenradio volumio[889]: error: Discovery: Generic error: Error: dns service error: unknown Mar 29 18:51:48 kchenradio volumio[889]: info: Discovery: Started advertising with name: KüchenRadio Mar 29 18:51:48 kchenradio volumio[889]: info: MyVolumio Plan changed: premium Mar 29 18:51:48 kchenradio volumio[889]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Mar 29 18:51:48 kchenradio volumio[889]: info: Removing browser output: myVolumio user plan is not superstar Mar 29 18:51:48 kchenradio volumio[889]: info: Removing audio output: Mar 29 18:51:48 kchenradio volumio[889]: info: MYVOLUMIO: Adding device Mar 29 18:51:48 kchenradio volumio[889]: info: MYVOLUMIO: Evaluating Server Mar 29 18:51:48 kchenradio volumio[889]: info: Remote config written successfully Mar 29 18:51:48 kchenradio volumio[889]: info: Starting Tunnel 1 Mar 29 18:51:48 kchenradio volumio[889]: info: Starting Tunnel Connection Checker Mar 29 18:51:48 kchenradio volumio[889]: info: MYVolumio Device enabled Mar 29 18:51:48 kchenradio volumio[889]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Mar 29 18:51:48 kchenradio volumio[889]: info: MyVolumio status changed Mar 29 18:51:48 kchenradio volumio[889]: info: Streaming services startup Mar 29 18:51:48 kchenradio volumio[889]: info: Starting Streaming Daemon Mar 29 18:51:48 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Mar 29 18:51:48 kchenradio sudo[1622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 29 18:51:48 kchenradio sudo[1622]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:48 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Mar 29 18:51:48 kchenradio sudo[1622]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:49 kchenradio volumio[889]: info: [1711734709138] Starting BluetoothController Mar 29 18:51:49 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Mar 29 18:51:51 kchenradio volumio[889]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Mar 29 18:51:51 kchenradio sudo[1625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 29 18:51:51 kchenradio sudo[1625]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:51 kchenradio sudo[1625]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:51 kchenradio volumio[889]: info: MRS: MultiRoom plugin initialized Mar 29 18:51:51 kchenradio volumio[889]: info: MRS: STOPPING SNAPCLIENT Mar 29 18:51:51 kchenradio volumio[889]: info: MRS: Snap server stop Mar 29 18:51:51 kchenradio sudo[1641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 29 18:51:51 kchenradio sudo[1641]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:51 kchenradio volumio[889]: info: MRS: STOPPING volumioStreaming Mar 29 18:51:51 kchenradio sudo[1641]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:51 kchenradio sudo[1644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 29 18:51:51 kchenradio sudo[1644]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:51 kchenradio sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 29 18:51:51 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Mar 29 18:51:51 kchenradio sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:51 kchenradio sudo[1644]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:51 kchenradio sudo[1649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 29 18:51:51 kchenradio sudo[1649]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:51 kchenradio sudo[1649]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:51 kchenradio sudo[1646]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:51 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Mar 29 18:51:51 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Mar 29 18:51:51 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Mar 29 18:51:51 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Mar 29 18:51:51 kchenradio volumio[889]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Mar 29 18:51:51 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Mar 29 18:51:51 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Mar 29 18:51:51 kchenradio volumio[889]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Mar 29 18:51:51 kchenradio volumio[889]: info: Preparing to generate the ALSA configuration file Mar 29 18:51:51 kchenradio volumio[889]: info: Initializing connection to go-librespot Websocket Mar 29 18:51:51 kchenradio volumio[889]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Mar 29 18:51:51 kchenradio volumio[889]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 29 18:51:51 kchenradio volumio[889]: info: Reading ALSA contributions from plugins. Mar 29 18:51:51 kchenradio volumio[889]: info: MRS: Removed streaming files Mar 29 18:51:51 kchenradio volumio[889]: info: MRS: volumioStreaming STOPPED Mar 29 18:51:51 kchenradio volumio[889]: info: MRS: SNAPSERVER STOPPED Mar 29 18:51:51 kchenradio volumio[889]: info: MRS: SNAPCLIENT STOPPED Mar 29 18:51:51 kchenradio volumio[889]: error: Cannot start Volumio Streaming Daemon Mar 29 18:51:51 kchenradio volumio[889]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 29 18:51:51 kchenradio volumio[889]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 29 18:51:51 kchenradio volumio[889]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 29 18:51:52 kchenradio volumio[889]: info: Asound.conf file written Mar 29 18:51:52 kchenradio sudo[1653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 29 18:51:52 kchenradio sudo[1653]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:52 kchenradio sudo[1653]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:52 kchenradio volumio[889]: info: Output device has changed, restarting MPD Mar 29 18:51:52 kchenradio volumio[889]: info: Output device has changed, restarting Shairport Sync Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:52 kchenradio sudo[1658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 29 18:51:52 kchenradio sudo[1658]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:52 kchenradio sudo[1658]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:52 kchenradio sudo[1660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 29 18:51:52 kchenradio sudo[1660]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:52 kchenradio systemd[1]: Requested transaction contradicts existing jobs: Transaction for mpd.service/restart is destructive (boot.mount has 'stop' job queued, but 'start' is included in transaction). Mar 29 18:51:52 kchenradio sudo[1660]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:52 kchenradio volumio[889]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 29 18:51:52 kchenradio volumio[889]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 18:51:52 kchenradio volumio[889]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 29 18:51:52 kchenradio volumio[889]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Mar 29 18:51:52 kchenradio volumio[889]: info: MRS: Pushing multiroomSync output for this device Mar 29 18:51:52 kchenradio volumio[889]: info: MRS: Pushing multiroomSync output Mar 29 18:51:52 kchenradio volumio[889]: info: Adding audio output: Mar 29 18:51:52 kchenradio volumio[889]: info: Adding audio output: Mar 29 18:51:52 kchenradio sudo[1669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name KüchenRadio Mar 29 18:51:52 kchenradio sudo[1669]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:52 kchenradio sudo[1669]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:52 kchenradio volumio[889]: Cast browser error: Error: dns service error: unknown Mar 29 18:51:52 kchenradio volumio[889]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'KüchenRadio' Mar 29 18:51:52 kchenradio volumio[889]: Can't change local name on hci0: Network is down (100) Mar 29 18:51:52 kchenradio volumio[889]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Mar 29 18:51:52 kchenradio volumio[889]: Failed to restart mpd.service: Transaction for mpd.service/restart is destructive (boot.mount has 'stop' job queued, but 'start' is included in transaction). Mar 29 18:51:52 kchenradio volumio[889]: See system logs and 'systemctl status mpd.service' for details. Mar 29 18:51:52 kchenradio volumio[889]: info: MPD Permissions set Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:52 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 18:51:52 kchenradio volumio[889]: info: Starting Shairport Sync Mar 29 18:51:52 kchenradio sudo[1677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 29 18:51:52 kchenradio sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:52 kchenradio systemd[1]: Requested transaction contradicts existing jobs: Transaction for shairport-sync.service/restart is destructive (system-systemd\x2dfsck.slice has 'stop' job queued, but 'start' is included in transaction). Mar 29 18:51:52 kchenradio sudo[1677]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:52 kchenradio volumio[889]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Mar 29 18:51:52 kchenradio volumio[889]: Failed to restart shairport-sync.service: Transaction for shairport-sync.service/restart is destructive (system-systemd\x2dfsck.slice has 'stop' job queued, but 'start' is included in transaction). Mar 29 18:51:52 kchenradio volumio[889]: See system logs and 'systemctl status shairport-sync.service' for details. Mar 29 18:51:53 kchenradio volumio[889]: error: Discovery: Generic error: Error: dns service error: unknown Mar 29 18:51:53 kchenradio volumio[889]: info: Discovery: Started advertising with name: KüchenRadio Mar 29 18:51:53 kchenradio sudo[1685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 29 18:51:53 kchenradio sudo[1685]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:53 kchenradio systemd[1]: Requested transaction contradicts existing jobs: Transaction for sshtunnel.service/restart is destructive (shutdown.target has 'start' job queued, but 'stop' is included in transaction). Mar 29 18:51:53 kchenradio sudo[1685]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:53 kchenradio volumio[889]: error: Cannot start Remote SSH: Error: Command failed: /usr/bin/sudo /bin/systemctl restart sshtunnel.service Mar 29 18:51:53 kchenradio volumio[889]: Failed to restart sshtunnel.service: Transaction for sshtunnel.service/restart is destructive (shutdown.target has 'start' job queued, but 'stop' is included in transaction). Mar 29 18:51:53 kchenradio volumio[889]: See system logs and 'systemctl status sshtunnel.service' for details. Mar 29 18:51:53 kchenradio volumio[889]: info: Setting Geolocation for MyVolumio to eu2 Mar 29 18:51:53 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:53 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:53 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:54 kchenradio volumio[889]: info: Updating MyVolumio device info Mar 29 18:51:54 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:54 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:54 kchenradio volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 18:51:54 kchenradio volumio[889]: info: Initializing connection to go-librespot Websocket Mar 29 18:51:55 kchenradio volumio[889]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 18:51:55 kchenradio sudo[1688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Mar 29 18:51:55 kchenradio sudo[1688]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 18:51:55 kchenradio volumio[889]: Error: write EPIPE Mar 29 18:51:55 kchenradio volumio[889]: at afterWriteDispatched (internal/stream_base_commons.js:156:25) Mar 29 18:51:55 kchenradio volumio[889]: at writeGeneric (internal/stream_base_commons.js:147:3) Mar 29 18:51:55 kchenradio volumio[889]: at Socket._writeGeneric (net.js:785:11) Mar 29 18:51:55 kchenradio volumio[889]: at Socket.connect (net.js:767:12) Mar 29 18:51:55 kchenradio volumio[889]: at Object.onceWrapper (events.js:421:28) Mar 29 18:51:55 kchenradio volumio[889]: at Socket.emit (events.js:327:22) Mar 29 18:51:55 kchenradio volumio[889]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1132:10) { Mar 29 18:51:55 kchenradio volumio[889]: errno: -32, Mar 29 18:51:55 kchenradio volumio[889]: code: 'EPIPE', Mar 29 18:51:55 kchenradio volumio[889]: syscall: 'write' Mar 29 18:51:55 kchenradio volumio[889]: } Mar 29 18:51:55 kchenradio volumio[889]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 18:51:55 kchenradio systemd[1]: Requested transaction contradicts existing jobs: Transaction for volumiobt.service/start is destructive (boot.mount has 'stop' job queued, but 'start' is included in transaction). Mar 29 18:51:55 kchenradio sudo[1688]: pam_unix(sudo:session): session closed for user root Mar 29 18:51:55 kchenradio sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-29 18:50 Mar 29 18:51:55 kchenradio sudo[1699]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"