-- Logs begin at Tue 2026-02-10 04:29:35 CET, end at Tue 2026-02-10 12:43:40 CET. -- Feb 10 12:42:03 kueche ifplugd(eth0)[744]: Link beat lost. Feb 10 12:42:04 kueche dhcpcd[873]: eth0: carrier lost Feb 10 12:42:04 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Down Feb 10 12:42:04 kueche dhcpcd[873]: eth0: deleting route to 192.168.178.0/24 Feb 10 12:42:04 kueche dhcpcd[873]: eth0: deleting default route via 192.168.178.1 Feb 10 12:42:04 kueche avahi-daemon[539]: Withdrawing address record for 192.168.178.73 on eth0. Feb 10 12:42:04 kueche avahi-daemon[539]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.178.73. Feb 10 12:42:04 kueche avahi-daemon[539]: Interface eth0.IPv4 no longer relevant for mDNS. Feb 10 12:42:04 kueche volumio[20977]: info: Discovery: A device disappeared from network Feb 10 12:42:04 kueche volumio[20977]: info: Discovery: Device kueche disappeared from network Feb 10 12:42:04 kueche volumio[20977]: info: Discovery: A device disappeared from network Feb 10 12:42:04 kueche volumio[20977]: info: Discovery: Device wohnen disappeared from network Feb 10 12:42:04 kueche volumio[20977]: info: Discovery: Disconnected from remote: 192.168.178.39 Feb 10 12:42:04 kueche ntpd[24168]: ntpd exiting on signal 15 (Terminated) Feb 10 12:42:04 kueche systemd[1]: Stopping Network Time Service... Feb 10 12:42:04 kueche ntpd[24168]: 192.168.178.1 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche systemd[1]: ntp.service: Succeeded. Feb 10 12:42:04 kueche ntpd[24168]: 185.252.140.125 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 139.162.152.20 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 212.132.108.186 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 139.162.156.95 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche systemd[1]: Stopped Network Time Service. Feb 10 12:42:04 kueche ntpd[24168]: 85.220.190.246 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 176.9.42.91 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 178.63.52.31 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 88.99.86.9 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 128.140.109.119 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 82.165.178.31 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 93.241.86.156 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 46.21.2.169 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche ntpd[24168]: 93.177.65.20 local addr 192.168.178.73 -> Feb 10 12:42:04 kueche systemd[1]: Starting Network Time Service... Feb 10 12:42:04 kueche ntpd[24280]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 10 12:42:04 kueche ntpd[24280]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Feb 10 12:42:04 kueche systemd[1]: Started Network Time Service. Feb 10 12:42:04 kueche ntpd[24286]: proto: precision = 0.573 usec (-21) Feb 10 12:42:04 kueche ntpd[24286]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 10 12:42:04 kueche ntpd[24286]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 10 12:42:04 kueche ntpd[24286]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 410 days ago Feb 10 12:42:04 kueche ntpd[24286]: Listen and drop on 0 v6wildcard [::]:123 Feb 10 12:42:04 kueche ntpd[24286]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 10 12:42:04 kueche ntpd[24286]: Listen normally on 2 lo 127.0.0.1:123 Feb 10 12:42:04 kueche ntpd[24286]: Listening on routing socket on fd #19 for interface updates Feb 10 12:42:04 kueche ntpd[24286]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:42:04 kueche ntpd[24286]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:42:05 kueche ntpd[24286]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 10 12:42:06 kueche ifplugd(eth0)[744]: Link beat detected. Feb 10 12:42:06 kueche dhcpcd[873]: eth0: carrier acquired Feb 10 12:42:06 kueche dhcpcd[873]: eth0: IAID eb:b1:b2:d6 Feb 10 12:42:06 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Feb 10 12:42:06 kueche dhcpcd[873]: eth0: soliciting an IPv6 router Feb 10 12:42:06 kueche ntpd[24286]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 10 12:42:06 kueche dhcpcd[873]: eth0: rebinding lease of 192.168.178.73 Feb 10 12:42:06 kueche dhcpcd[873]: eth0: probing address 192.168.178.73/24 Feb 10 12:42:06 kueche volumio[20977]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 12:42:06 kueche volumio[20977]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 10 12:42:06 kueche volumio[20977]: at doSend (dgram.js:692:16) Feb 10 12:42:06 kueche volumio[20977]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 10 12:42:06 kueche volumio[20977]: at afterDns (dgram.js:638:5) Feb 10 12:42:06 kueche volumio[20977]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 10 12:42:06 kueche volumio[20977]: errno: -101, Feb 10 12:42:06 kueche volumio[20977]: code: 'ENETUNREACH', Feb 10 12:42:06 kueche volumio[20977]: syscall: 'send', Feb 10 12:42:06 kueche volumio[20977]: address: '255.255.255.255', Feb 10 12:42:06 kueche volumio[20977]: port: 3483 Feb 10 12:42:06 kueche volumio[20977]: } Feb 10 12:42:06 kueche volumio[20977]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 12:42:07 kueche sudo[24298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-10 12:41 Feb 10 12:42:07 kueche sudo[24298]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:07 kueche sudo[24298]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:07 kueche volumio-remote-updater[27958]: [2026-02-10 12:42:07] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 10 12:42:07 kueche volumio-remote-updater[27958]: [2026-02-10 12:42:07] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 10 12:42:07 kueche systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 10 12:42:07 kueche systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 10 12:42:07 kueche systemd[1]: Started dynamicswap service. Feb 10 12:42:07 kueche systemd[1]: dynamicswap.service: Succeeded. Feb 10 12:42:07 kueche ntpd[24286]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 10 12:42:07 kueche systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 10 12:42:07 kueche systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4486. Feb 10 12:42:07 kueche systemd[1]: Started dynamicswap service. Feb 10 12:42:07 kueche systemd[1]: Stopped Volumio Backend Module. Feb 10 12:42:07 kueche systemd[1]: Started Volumio Backend Module. Feb 10 12:42:07 kueche systemd[1]: dynamicswap.service: Succeeded. Feb 10 12:42:08 kueche ntpd[24286]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 10 12:42:09 kueche volumio[24313]: info: ------------------------------------------- Feb 10 12:42:09 kueche volumio[24313]: info: ----- Volumio3 ---- Feb 10 12:42:09 kueche volumio[24313]: info: ------------------------------------------- Feb 10 12:42:09 kueche volumio[24313]: info: ----- System startup ---- Feb 10 12:42:09 kueche volumio[24313]: info: ------------------------------------------- Feb 10 12:42:09 kueche volumio[24313]: info: MYVOLUMIO Environment detected Feb 10 12:42:09 kueche volumio[24313]: info: Plugin folders cleanup Feb 10 12:42:09 kueche volumio[24313]: info: Scanning into folder /volumio/app/plugins/ Feb 10 12:42:09 kueche volumio[24313]: info: Scanning category audio_interface Feb 10 12:42:09 kueche volumio[24313]: info: Scanning category miscellanea Feb 10 12:42:09 kueche volumio[24313]: info: Scanning category music_service Feb 10 12:42:09 kueche volumio[24313]: info: Scanning category plugins.json Feb 10 12:42:09 kueche volumio[24313]: info: Scanning category system_controller Feb 10 12:42:09 kueche volumio[24313]: info: Scanning category user_interface Feb 10 12:42:09 kueche volumio[24313]: info: Scanning into folder /data/plugins/ Feb 10 12:42:09 kueche volumio[24313]: info: Scanning category music_service Feb 10 12:42:09 kueche volumio[24313]: info: Plugin folders cleanup completed Feb 10 12:42:09 kueche volumio[24313]: info: ------------------------------------------- Feb 10 12:42:09 kueche volumio[24313]: info: ----- Core plugins startup ---- Feb 10 12:42:09 kueche volumio[24313]: info: ------------------------------------------- Feb 10 12:42:09 kueche volumio[24313]: info: Loading plugins from folder /volumio/app/plugins/ Feb 10 12:42:09 kueche volumio[24313]: info: Adding plugin upnp to MyMusic Plugins Feb 10 12:42:09 kueche volumio[24313]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 10 12:42:09 kueche volumio[24313]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 10 12:42:09 kueche volumio[24313]: info: Loading plugins from folder /data/plugins/ Feb 10 12:42:09 kueche volumio[24313]: info: Loading plugin "system"... Feb 10 12:42:10 kueche volumio[24313]: info: Loading plugin "appearance"... Feb 10 12:42:10 kueche volumio[24313]: info: Loading plugin "network"... Feb 10 12:42:10 kueche volumio[24313]: info: Refreshing Cached IP Addresses Feb 10 12:42:10 kueche sudo[24339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 10 12:42:10 kueche sudo[24339]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:10 kueche sudo[24339]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:10 kueche sudo[24341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 10 12:42:10 kueche sudo[24341]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:10 kueche sudo[24341]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:10 kueche volumio[24313]: info: Loading plugin "services"... Feb 10 12:42:10 kueche volumio[24313]: info: Loading plugin "alsa_controller"... Feb 10 12:42:11 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "wizard"... Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "networkfs"... Feb 10 12:42:11 kueche volumio[24313]: info: Cannot mount NAS Fritz at system boot, trial number 1 ,retrying in 5 seconds Feb 10 12:42:11 kueche volumio[24313]: info: Starting Udev Watcher for removable devices Feb 10 12:42:11 kueche volumio[24313]: info: Ignoring mount for partition: boot Feb 10 12:42:11 kueche volumio[24313]: info: Ignoring mount for partition: volumio Feb 10 12:42:11 kueche volumio[24313]: info: Ignoring mount for partition: volumio_data Feb 10 12:42:11 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "volumio_command_line_client"... Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "upnp"... Feb 10 12:42:11 kueche volumio[24313]: info: [1770723731175] Starting Upmpd Daemon Feb 10 12:42:11 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "my_music"... Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "mpd"... Feb 10 12:42:11 kueche dhcpcd[873]: eth0: leased 192.168.178.73 for 864000 seconds Feb 10 12:42:11 kueche avahi-daemon[539]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.178.73. Feb 10 12:42:11 kueche dhcpcd[873]: eth0: adding route to 192.168.178.0/24 Feb 10 12:42:11 kueche avahi-daemon[539]: New relevant interface eth0.IPv4 for mDNS. Feb 10 12:42:11 kueche dhcpcd[873]: eth0: adding default route via 192.168.178.1 Feb 10 12:42:11 kueche avahi-daemon[539]: Registering new address record for 192.168.178.73 on eth0.IPv4. Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "upnp_browser"... Feb 10 12:42:11 kueche ntpd[24286]: ntpd exiting on signal 15 (Terminated) Feb 10 12:42:11 kueche systemd[1]: Stopping Network Time Service... Feb 10 12:42:11 kueche systemd[1]: ntp.service: Succeeded. Feb 10 12:42:11 kueche systemd[1]: Stopped Network Time Service. Feb 10 12:42:11 kueche systemd[1]: Starting Network Time Service... Feb 10 12:42:11 kueche ntpd[24395]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 10 12:42:11 kueche ntpd[24395]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Feb 10 12:42:11 kueche systemd[1]: Started Network Time Service. Feb 10 12:42:11 kueche ntpd[24401]: proto: precision = 0.625 usec (-21) Feb 10 12:42:11 kueche ntpd[24401]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 10 12:42:11 kueche ntpd[24401]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 10 12:42:11 kueche ntpd[24401]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 410 days ago Feb 10 12:42:11 kueche ntpd[24401]: Listen and drop on 0 v6wildcard [::]:123 Feb 10 12:42:11 kueche ntpd[24401]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 10 12:42:11 kueche ntpd[24401]: Listen normally on 2 lo 127.0.0.1:123 Feb 10 12:42:11 kueche ntpd[24401]: Listen normally on 3 eth0 192.168.178.73:123 Feb 10 12:42:11 kueche ntpd[24401]: Listening on routing socket on fd #20 for interface updates Feb 10 12:42:11 kueche ntpd[24401]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:42:11 kueche ntpd[24401]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "alarm-clock"... Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "airplay_emulation"... Feb 10 12:42:11 kueche volumio[24313]: info: Starting Shairport Sync Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "last_100"... Feb 10 12:42:11 kueche volumio[24313]: info: Loading plugin "webradio"... Feb 10 12:42:12 kueche volumio[24313]: info: Loading plugin "i2s_dacs"... Feb 10 12:42:12 kueche volumio[24313]: info: Loading plugin "volumiodiscovery"... Feb 10 12:42:12 kueche volumio[24313]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 10 12:42:12 kueche volumio[24313]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 12:42:12 kueche volumio[24313]: *** WARNING *** For more information see Feb 10 12:42:12 kueche node[24313]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 10 12:42:12 kueche volumio[24313]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 10 12:42:12 kueche volumio[24313]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 12:42:12 kueche volumio[24313]: *** WARNING *** For more information see Feb 10 12:42:12 kueche node[24313]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 12:42:12 kueche node[24313]: *** WARNING *** For more information see Feb 10 12:42:12 kueche node[24313]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 10 12:42:12 kueche node[24313]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 12:42:12 kueche node[24313]: *** WARNING *** For more information see Feb 10 12:42:12 kueche volumio[24313]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 10 12:42:12 kueche volumio[24313]: info: Discovery: Started advertising with name: kueche Feb 10 12:42:12 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 10 12:42:12 kueche volumio[24313]: info: Loading plugin "squeezelite_mc"... Feb 10 12:42:12 kueche volumio-remote-updater[27958]: [2026-02-10 12:42:12] [connect] Successful connection Feb 10 12:42:12 kueche ntpd[24401]: Soliciting pool server 185.252.140.125 Feb 10 12:42:12 kueche volumio[24313]: info: Loading plugin "ytcr"... Feb 10 12:42:13 kueche ntpd[24401]: Soliciting pool server 139.162.152.20 Feb 10 12:42:13 kueche ntpd[24401]: Soliciting pool server 162.159.200.1 Feb 10 12:42:14 kueche ntpd[24401]: Soliciting pool server 148.251.235.164 Feb 10 12:42:14 kueche ntpd[24401]: Soliciting pool server 85.220.190.246 Feb 10 12:42:14 kueche ntpd[24401]: Soliciting pool server 176.9.42.91 Feb 10 12:42:15 kueche ntpd[24401]: Soliciting pool server 129.70.132.36 Feb 10 12:42:15 kueche ntpd[24401]: Soliciting pool server 142.132.200.241 Feb 10 12:42:15 kueche ntpd[24401]: Soliciting pool server 88.99.86.9 Feb 10 12:42:15 kueche ntpd[24401]: Soliciting pool server 128.140.109.119 Feb 10 12:42:16 kueche ntpd[24401]: Soliciting pool server 93.241.86.156 Feb 10 12:42:16 kueche ntpd[24401]: Soliciting pool server 136.243.7.20 Feb 10 12:42:16 kueche ntpd[24401]: Soliciting pool server 81.169.233.252 Feb 10 12:42:16 kueche volumio[24313]: info: Loading plugin "outputs"... Feb 10 12:42:16 kueche volumio[24313]: info: Loading plugin "albumart"... Feb 10 12:42:16 kueche volumio[24313]: info: Plugin example_plugin is not enabled Feb 10 12:42:16 kueche volumio[24313]: info: Loading plugin "inputs"... Feb 10 12:42:16 kueche volumio[24313]: info: Loading plugin "updater_comm"... Feb 10 12:42:17 kueche volumio[24313]: info: Plugin mpdemulation is not enabled Feb 10 12:42:17 kueche volumio[24313]: info: Loading plugin "rest_api"... Feb 10 12:42:17 kueche volumio[24313]: info: Loading plugin "websocket"... Feb 10 12:42:17 kueche volumio[24313]: info: Starting Socket.io Server version 2.3.0 Feb 10 12:42:17 kueche volumio[24313]: info: Loading i18n strings for locale de Feb 10 12:42:17 kueche volumio[24313]: Updating browse sources language Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 12:42:17 kueche volumio[24313]: Forking 3 albumart workers Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::initPlayerControls Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 12:42:17 kueche volumio[24313]: Express server listening on port 3000 Feb 10 12:42:17 kueche volumio[24313]: [Metrics] WebUI: 8s 579.85ms Feb 10 12:42:17 kueche volumio[24313]: info: CoreStateMachine::resetVolumioState Feb 10 12:42:17 kueche volumio[24313]: info: CoreStateMachine::getcurrentVolume Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::volumioRetrievevolume Feb 10 12:42:17 kueche volumio[24313]: info: Cannot mount NAS Fritz at system boot, trial number 2 ,retrying in 5 seconds Feb 10 12:42:17 kueche volumio[24313]: info: Cannot read play queue from file Feb 10 12:42:17 kueche volumio[24313]: info: Volumio Network Manager: Network status updated: 0 Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:17 kueche volumio[24313]: info: Executing start script for DAC IQaudIO DAC Plus Feb 10 12:42:17 kueche volumio[24313]: info: Setting Device type: Raspberry PI Feb 10 12:42:17 kueche volumio[24313]: info: CoreStateMachine::setRepeat null single undefined Feb 10 12:42:17 kueche ntpd[24401]: Soliciting pool server 46.21.2.169 Feb 10 12:42:17 kueche volumio[24313]: info: CoreStateMachine::pushState Feb 10 12:42:17 kueche ntpd[24401]: Soliciting pool server 46.224.156.215 Feb 10 12:42:17 kueche volumio[24313]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:17 kueche volumio[24313]: info: CoreStateMachine::setRandom null Feb 10 12:42:17 kueche volumio[24313]: info: CoreStateMachine::pushState Feb 10 12:42:17 kueche volumio[24313]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:17 kueche volumio[24313]: info: VolumeController:: Volume=100 Mute =false Feb 10 12:42:17 kueche volumio[24313]: info: CoreStateMachine::pushState Feb 10 12:42:17 kueche volumio[24313]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:17 kueche volumio[24313]: info: CoreStateMachine::updateTrackBlock Feb 10 12:42:17 kueche volumio[24313]: info: CorePlayQueue::getTrackBlock Feb 10 12:42:17 kueche volumio[24313]: info: CoreCommandRouter::volumioRetrievevolume Feb 10 12:42:17 kueche volumio[24313]: info: DAC script executed Feb 10 12:42:17 kueche volumio[24313]: info: Completed loading Core Plugins Feb 10 12:42:17 kueche volumio[24313]: info: Preparing to generate the ALSA configuration file Feb 10 12:42:17 kueche volumio[24313]: info: Asound.conf file unchanged, so no further update is needed Feb 10 12:42:17 kueche volumio[24313]: info: Output device has changed, restarting MPD Feb 10 12:42:18 kueche sudo[24492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 10 12:42:18 kueche sudo[24492]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:18 kueche volumio[24313]: info: Output device has changed, restarting Shairport Sync Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:18 kueche sudo[24492]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:18 kueche sudo[24495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 10 12:42:18 kueche sudo[24495]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:18 kueche systemd[1]: Stopping Music Player Daemon... Feb 10 12:42:18 kueche volumio[24313]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 10 12:42:18 kueche systemd[1]: mpd.service: Succeeded. Feb 10 12:42:18 kueche systemd[1]: Stopped Music Player Daemon. Feb 10 12:42:18 kueche volumio[24313]: info: ___________ START PLUGINS ___________ Feb 10 12:42:18 kueche volumio[24313]: info: ControllerMpd::onStart: Initializing MPD Feb 10 12:42:18 kueche volumio[24313]: info: Creating MPD Configuration file Feb 10 12:42:18 kueche sudo[24502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 10 12:42:18 kueche sudo[24502]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:18 kueche sudo[24502]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:18 kueche systemd[1]: Starting Music Player Daemon... Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 10 12:42:18 kueche volumio[24313]: info: [1770723738283] CoreMusicLibrary::Adding element Medienserver Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 12:42:18 kueche volumio[24313]: Starting albumart workers Feb 10 12:42:18 kueche volumio[24313]: Starting albumart workers Feb 10 12:42:18 kueche sudo[24505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 10 12:42:18 kueche sudo[24505]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:18 kueche sudo[24501]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 10 12:42:18 kueche sudo[24501]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:18 kueche sudo[24501]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:18 kueche systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 10 12:42:18 kueche systemd[1]: mpd.service: Succeeded. Feb 10 12:42:18 kueche systemd[1]: Stopped Music Player Daemon. Feb 10 12:42:18 kueche volumio[24313]: Starting albumart workers Feb 10 12:42:18 kueche volumio[24313]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:18 kueche systemd[1]: Starting Music Player Daemon... Feb 10 12:42:18 kueche dhcpcd[873]: eth0: carrier lost Feb 10 12:42:18 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Down Feb 10 12:42:18 kueche volumio[24313]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 10 12:42:18 kueche volumio[24313]: info: [1770723738558] CoreMusicLibrary::Adding element Last_100 Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 10 12:42:18 kueche volumio[24313]: info: [1770723738573] CoreMusicLibrary::Adding element Webradio Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 12:42:18 kueche volumio[24313]: info: Initializing BBC Radios Feb 10 12:42:18 kueche sudo[24508]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 10 12:42:18 kueche sudo[24508]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:18 kueche sudo[24508]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:18 kueche dhcpcd[873]: eth0: deleting route to 192.168.178.0/24 Feb 10 12:42:18 kueche dhcpcd[873]: eth0: deleting default route via 192.168.178.1 Feb 10 12:42:18 kueche avahi-daemon[539]: Withdrawing address record for 192.168.178.73 on eth0. Feb 10 12:42:18 kueche avahi-daemon[539]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.178.73. Feb 10 12:42:18 kueche avahi-daemon[539]: Interface eth0.IPv4 no longer relevant for mDNS. Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 12:42:18 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:18 kueche volumio[24313]: info: [squeezelite_mc] Starting proxy server... Feb 10 12:42:18 kueche systemd[1]: Stopping Network Time Service... Feb 10 12:42:18 kueche ntpd[24401]: ntpd exiting on signal 15 (Terminated) Feb 10 12:42:18 kueche ntpd[24401]: 192.168.178.1 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche systemd[1]: ntp.service: Succeeded. Feb 10 12:42:18 kueche ntpd[24401]: 185.252.140.125 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 139.162.152.20 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 162.159.200.1 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 85.220.190.246 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche systemd[1]: Stopped Network Time Service. Feb 10 12:42:18 kueche ntpd[24401]: 148.251.235.164 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 176.9.42.91 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 142.132.200.241 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 88.99.86.9 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 129.70.132.36 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 128.140.109.119 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 136.243.7.20 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 93.241.86.156 local addr 192.168.178.73 -> Feb 10 12:42:18 kueche ntpd[24401]: 81.169.233.252 local addr 192.168.178.73 -> Feb 10 12:42:19 kueche systemd[1]: Starting Network Time Service... Feb 10 12:42:19 kueche volumio[24313]: info: Volumio Calling Home Feb 10 12:42:19 kueche ntpd[24570]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 10 12:42:19 kueche ntpd[24570]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Feb 10 12:42:19 kueche systemd[1]: Started Network Time Service. Feb 10 12:42:19 kueche ntpd[24578]: proto: precision = 0.573 usec (-21) Feb 10 12:42:19 kueche ntpd[24578]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 10 12:42:19 kueche ntpd[24578]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 10 12:42:19 kueche ntpd[24578]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 410 days ago Feb 10 12:42:19 kueche ntpd[24578]: Listen and drop on 0 v6wildcard [::]:123 Feb 10 12:42:19 kueche ntpd[24578]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 10 12:42:19 kueche ntpd[24578]: Listen normally on 2 lo 127.0.0.1:123 Feb 10 12:42:19 kueche ntpd[24578]: Listening on routing socket on fd #19 for interface updates Feb 10 12:42:19 kueche ntpd[24578]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:42:19 kueche ntpd[24578]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:42:19 kueche ifplugd(eth0)[744]: Link beat lost. Feb 10 12:42:19 kueche volumio[24313]: info: [squeezelite_mc] Proxy server started on port 41987 Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::volumioRetrievevolume Feb 10 12:42:19 kueche volumio[24313]: info: MPD Permissions set Feb 10 12:42:19 kueche volumio[24313]: info: MPD Permissions set Feb 10 12:42:19 kueche volumio[24313]: info: VolumeController:: Volume=100 Mute =false Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:19 kueche volumio[24313]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:19 kueche volumio[24313]: info: CoreStateMachine::pushState Feb 10 12:42:19 kueche volumio[24313]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: Discovery: A device disappeared from network Feb 10 12:42:19 kueche volumio[24313]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Feb 10 12:42:19 kueche volumio[24313]: info: VolumeController:: Volume=100 Mute =false Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:19 kueche volumio[24313]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:19 kueche volumio[24313]: info: CoreStateMachine::pushState Feb 10 12:42:19 kueche volumio[24313]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:19 kueche volumio[24313]: info: [squeezelite_mc] Server discovery started Feb 10 12:42:19 kueche volumio[24313]: info: [squeezelite_mc] Player finder started Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 12:42:19 kueche volumio[24313]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 10 12:42:19 kueche volumio[24313]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 12:42:19 kueche volumio[24313]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 10 12:42:19 kueche volumio[24313]: at doSend (dgram.js:692:16) Feb 10 12:42:19 kueche volumio[24313]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 10 12:42:19 kueche volumio[24313]: at afterDns (dgram.js:638:5) Feb 10 12:42:19 kueche volumio[24313]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 10 12:42:19 kueche volumio[24313]: errno: -101, Feb 10 12:42:19 kueche volumio[24313]: code: 'ENETUNREACH', Feb 10 12:42:19 kueche volumio[24313]: syscall: 'send', Feb 10 12:42:19 kueche volumio[24313]: address: '255.255.255.255', Feb 10 12:42:19 kueche volumio[24313]: port: 3483 Feb 10 12:42:19 kueche volumio[24313]: } Feb 10 12:42:19 kueche volumio[24313]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 12:42:20 kueche ntpd[24578]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 10 12:42:20 kueche sudo[24626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-10 12:41 Feb 10 12:42:20 kueche sudo[24626]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:20 kueche sudo[24626]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:20 kueche mpd[24540]: Feb 10 12:42 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 10 12:42:20 kueche systemd[1]: Started Music Player Daemon. Feb 10 12:42:20 kueche sudo[24505]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:20 kueche sudo[24495]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:21 kueche ntpd[24578]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 10 12:42:21 kueche ifplugd(eth0)[744]: Link beat detected. Feb 10 12:42:21 kueche dhcpcd[873]: eth0: carrier acquired Feb 10 12:42:21 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Feb 10 12:42:21 kueche dhcpcd[873]: eth0: IAID eb:b1:b2:d6 Feb 10 12:42:21 kueche dhcpcd[873]: eth0: soliciting an IPv6 router Feb 10 12:42:22 kueche ntpd[24578]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 10 12:42:22 kueche dhcpcd[873]: eth0: rebinding lease of 192.168.178.73 Feb 10 12:42:22 kueche dhcpcd[873]: eth0: probing address 192.168.178.73/24 Feb 10 12:42:23 kueche ntpd[24578]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 10 12:42:24 kueche volumio-remote-updater[27958]: [2026-02-10 12:42:24] [connect] Successful connection Feb 10 12:42:27 kueche volumio-remote-updater[27958]: [2026-02-10 12:42:27] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Feb 10 12:42:27 kueche volumio-remote-updater[27958]: [2026-02-10 12:42:27] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Feb 10 12:42:27 kueche volumio-remote-updater[27958]: [2026-02-10 12:42:27] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 10 12:42:27 kueche systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 10 12:42:28 kueche systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 10 12:42:28 kueche systemd[1]: Started dynamicswap service. Feb 10 12:42:28 kueche systemd[1]: dynamicswap.service: Succeeded. Feb 10 12:42:28 kueche dhcpcd[873]: eth0: leased 192.168.178.73 for 864000 seconds Feb 10 12:42:28 kueche avahi-daemon[539]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.178.73. Feb 10 12:42:28 kueche avahi-daemon[539]: New relevant interface eth0.IPv4 for mDNS. Feb 10 12:42:28 kueche avahi-daemon[539]: Registering new address record for 192.168.178.73 on eth0.IPv4. Feb 10 12:42:28 kueche dhcpcd[873]: eth0: adding route to 192.168.178.0/24 Feb 10 12:42:28 kueche dhcpcd[873]: eth0: adding default route via 192.168.178.1 Feb 10 12:42:28 kueche systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 10 12:42:28 kueche systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4487. Feb 10 12:42:28 kueche systemd[1]: Stopped Volumio Backend Module. Feb 10 12:42:28 kueche systemd[1]: Started Volumio Backend Module. Feb 10 12:42:28 kueche systemd[1]: Started dynamicswap service. Feb 10 12:42:28 kueche systemd[1]: dynamicswap.service: Succeeded. Feb 10 12:42:28 kueche ntpd[24578]: ntpd exiting on signal 15 (Terminated) Feb 10 12:42:28 kueche systemd[1]: Stopping Network Time Service... Feb 10 12:42:28 kueche systemd[1]: ntp.service: Succeeded. Feb 10 12:42:28 kueche systemd[1]: Stopped Network Time Service. Feb 10 12:42:28 kueche systemd[1]: Starting Network Time Service... Feb 10 12:42:28 kueche ntpd[24702]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 10 12:42:28 kueche ntpd[24702]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Feb 10 12:42:28 kueche systemd[1]: Started Network Time Service. Feb 10 12:42:28 kueche ntpd[24708]: proto: precision = 0.573 usec (-21) Feb 10 12:42:28 kueche ntpd[24708]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 10 12:42:28 kueche ntpd[24708]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 10 12:42:28 kueche ntpd[24708]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 410 days ago Feb 10 12:42:28 kueche ntpd[24708]: Listen and drop on 0 v6wildcard [::]:123 Feb 10 12:42:28 kueche ntpd[24708]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 10 12:42:28 kueche ntpd[24708]: Listen normally on 2 lo 127.0.0.1:123 Feb 10 12:42:28 kueche ntpd[24708]: Listen normally on 3 eth0 192.168.178.73:123 Feb 10 12:42:28 kueche ntpd[24708]: Listening on routing socket on fd #20 for interface updates Feb 10 12:42:28 kueche ntpd[24708]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:42:28 kueche ntpd[24708]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:42:29 kueche ntpd[24708]: Soliciting pool server 185.252.140.125 Feb 10 12:42:29 kueche volumio[24685]: info: ------------------------------------------- Feb 10 12:42:29 kueche volumio[24685]: info: ----- Volumio3 ---- Feb 10 12:42:29 kueche volumio[24685]: info: ------------------------------------------- Feb 10 12:42:29 kueche volumio[24685]: info: ----- System startup ---- Feb 10 12:42:29 kueche volumio[24685]: info: ------------------------------------------- Feb 10 12:42:30 kueche ntpd[24708]: Soliciting pool server 139.162.152.20 Feb 10 12:42:30 kueche ntpd[24708]: Soliciting pool server 162.159.200.1 Feb 10 12:42:30 kueche volumio[24685]: info: MYVOLUMIO Environment detected Feb 10 12:42:30 kueche volumio[24685]: info: Plugin folders cleanup Feb 10 12:42:30 kueche volumio[24685]: info: Scanning into folder /volumio/app/plugins/ Feb 10 12:42:30 kueche volumio[24685]: info: Scanning category audio_interface Feb 10 12:42:30 kueche volumio[24685]: info: Scanning category miscellanea Feb 10 12:42:30 kueche volumio[24685]: info: Scanning category music_service Feb 10 12:42:30 kueche volumio[24685]: info: Scanning category plugins.json Feb 10 12:42:30 kueche volumio[24685]: info: Scanning category system_controller Feb 10 12:42:30 kueche volumio[24685]: info: Scanning category user_interface Feb 10 12:42:30 kueche volumio[24685]: info: Scanning into folder /data/plugins/ Feb 10 12:42:30 kueche volumio[24685]: info: Scanning category music_service Feb 10 12:42:30 kueche volumio[24685]: info: Plugin folders cleanup completed Feb 10 12:42:30 kueche volumio[24685]: info: ------------------------------------------- Feb 10 12:42:30 kueche volumio[24685]: info: ----- Core plugins startup ---- Feb 10 12:42:30 kueche volumio[24685]: info: ------------------------------------------- Feb 10 12:42:30 kueche volumio[24685]: info: Loading plugins from folder /volumio/app/plugins/ Feb 10 12:42:30 kueche volumio[24685]: info: Adding plugin upnp to MyMusic Plugins Feb 10 12:42:30 kueche volumio[24685]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 10 12:42:30 kueche volumio[24685]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 10 12:42:30 kueche volumio[24685]: info: Loading plugins from folder /data/plugins/ Feb 10 12:42:30 kueche volumio[24685]: info: Loading plugin "system"... Feb 10 12:42:30 kueche volumio[24685]: info: Loading plugin "appearance"... Feb 10 12:42:31 kueche ntpd[24708]: Soliciting pool server 148.251.235.164 Feb 10 12:42:31 kueche ntpd[24708]: Soliciting pool server 85.220.190.246 Feb 10 12:42:31 kueche ntpd[24708]: Soliciting pool server 176.9.42.91 Feb 10 12:42:31 kueche volumio[24685]: info: Loading plugin "network"... Feb 10 12:42:31 kueche volumio[24685]: info: Refreshing Cached IP Addresses Feb 10 12:42:31 kueche sudo[24724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 10 12:42:31 kueche sudo[24724]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:31 kueche sudo[24724]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:31 kueche sudo[24726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 10 12:42:31 kueche volumio[24685]: info: Loading plugin "services"... Feb 10 12:42:31 kueche sudo[24726]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:31 kueche volumio[24685]: info: Loading plugin "alsa_controller"... Feb 10 12:42:31 kueche sudo[24726]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:31 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 12:42:31 kueche volumio[24685]: info: Loading plugin "wizard"... Feb 10 12:42:31 kueche volumio[24685]: info: Loading plugin "networkfs"... Feb 10 12:42:31 kueche volumio[24685]: info: Cannot mount NAS Fritz at system boot, trial number 1 ,retrying in 5 seconds Feb 10 12:42:31 kueche volumio[24685]: info: Starting Udev Watcher for removable devices Feb 10 12:42:31 kueche volumio[24685]: info: Ignoring mount for partition: boot Feb 10 12:42:31 kueche volumio[24685]: info: Ignoring mount for partition: volumio Feb 10 12:42:31 kueche volumio[24685]: info: Ignoring mount for partition: volumio_data Feb 10 12:42:31 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 10 12:42:31 kueche volumio[24685]: info: Loading plugin "volumio_command_line_client"... Feb 10 12:42:31 kueche volumio[24685]: info: Loading plugin "upnp"... Feb 10 12:42:31 kueche volumio[24685]: info: [1770723751794] Starting Upmpd Daemon Feb 10 12:42:31 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 10 12:42:31 kueche volumio[24685]: info: Loading plugin "my_music"... Feb 10 12:42:31 kueche volumio[24685]: info: Loading plugin "mpd"... Feb 10 12:42:32 kueche volumio[24685]: info: Loading plugin "upnp_browser"... Feb 10 12:42:32 kueche volumio[24685]: info: Loading plugin "alarm-clock"... Feb 10 12:42:32 kueche ntpd[24708]: Soliciting pool server 129.70.132.36 Feb 10 12:42:32 kueche ntpd[24708]: Soliciting pool server 142.132.200.241 Feb 10 12:42:32 kueche ntpd[24708]: Soliciting pool server 88.99.86.9 Feb 10 12:42:32 kueche ntpd[24708]: Soliciting pool server 128.140.109.119 Feb 10 12:42:32 kueche volumio[24685]: info: Loading plugin "airplay_emulation"... Feb 10 12:42:32 kueche volumio[24685]: info: Starting Shairport Sync Feb 10 12:42:32 kueche volumio[24685]: info: Loading plugin "last_100"... Feb 10 12:42:32 kueche volumio[24685]: info: Loading plugin "webradio"... Feb 10 12:42:32 kueche volumio[24685]: info: Loading plugin "i2s_dacs"... Feb 10 12:42:32 kueche volumio[24685]: info: Loading plugin "volumiodiscovery"... Feb 10 12:42:32 kueche volumio[24685]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 10 12:42:32 kueche volumio[24685]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 12:42:32 kueche volumio[24685]: *** WARNING *** For more information see Feb 10 12:42:32 kueche node[24685]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 10 12:42:32 kueche volumio[24685]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 10 12:42:32 kueche volumio[24685]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 12:42:32 kueche volumio[24685]: *** WARNING *** For more information see Feb 10 12:42:32 kueche node[24685]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 12:42:32 kueche node[24685]: *** WARNING *** For more information see Feb 10 12:42:32 kueche node[24685]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 10 12:42:32 kueche node[24685]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 10 12:42:32 kueche node[24685]: *** WARNING *** For more information see Feb 10 12:42:32 kueche volumio[24685]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 10 12:42:32 kueche volumio[24685]: info: Discovery: Started advertising with name: kueche Feb 10 12:42:32 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 10 12:42:32 kueche volumio[24685]: info: Loading plugin "squeezelite_mc"... Feb 10 12:42:33 kueche ntpd[24708]: Soliciting pool server 93.241.86.156 Feb 10 12:42:33 kueche ntpd[24708]: Soliciting pool server 136.243.7.20 Feb 10 12:42:33 kueche ntpd[24708]: Soliciting pool server 81.169.233.252 Feb 10 12:42:33 kueche volumio[24685]: info: Loading plugin "ytcr"... Feb 10 12:42:34 kueche ntpd[24708]: Soliciting pool server 46.21.2.169 Feb 10 12:42:34 kueche ntpd[24708]: Soliciting pool server 46.224.156.215 Feb 10 12:42:35 kueche ntpd[24708]: Soliciting pool server 93.177.65.20 Feb 10 12:42:35 kueche ntpd[24708]: Soliciting pool server 2a01:239:25e:bd00::4 Feb 10 12:42:37 kueche volumio[24685]: info: Loading plugin "outputs"... Feb 10 12:42:37 kueche volumio[24685]: info: Loading plugin "albumart"... Feb 10 12:42:37 kueche volumio[24685]: info: Plugin example_plugin is not enabled Feb 10 12:42:37 kueche volumio[24685]: info: Loading plugin "inputs"... Feb 10 12:42:37 kueche volumio[24685]: info: Loading plugin "updater_comm"... Feb 10 12:42:37 kueche volumio[24685]: info: Plugin mpdemulation is not enabled Feb 10 12:42:37 kueche volumio[24685]: info: Loading plugin "rest_api"... Feb 10 12:42:37 kueche volumio[24685]: info: Loading plugin "websocket"... Feb 10 12:42:37 kueche volumio[24685]: info: Starting Socket.io Server version 2.3.0 Feb 10 12:42:37 kueche volumio[24685]: info: Loading i18n strings for locale de Feb 10 12:42:37 kueche volumio[24685]: Updating browse sources language Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 12:42:37 kueche volumio[24685]: Forking 3 albumart workers Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::initPlayerControls Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 12:42:37 kueche volumio[24685]: Express server listening on port 3000 Feb 10 12:42:37 kueche volumio[24685]: [Metrics] WebUI: 8s 445.64ms Feb 10 12:42:37 kueche volumio[24685]: info: CoreStateMachine::resetVolumioState Feb 10 12:42:37 kueche volumio[24685]: info: CoreStateMachine::getcurrentVolume Feb 10 12:42:37 kueche volumio[24685]: info: CoreCommandRouter::volumioRetrievevolume Feb 10 12:42:37 kueche volumio[24685]: info: Cannot mount NAS Fritz at system boot, trial number 2 ,retrying in 5 seconds Feb 10 12:42:37 kueche volumio[24685]: info: Cannot read play queue from file Feb 10 12:42:37 kueche volumio[24685]: info: Volumio Network Manager: Network status updated: 1 Feb 10 12:42:37 kueche volumio-remote-updater[27958]: [2026-02-10 12:42:37] [connect] Successful connection Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:38 kueche volumio[24685]: info: Executing start script for DAC IQaudIO DAC Plus Feb 10 12:42:38 kueche volumio-remote-updater[27958]: [2026-02-10 12:42:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770723757 101 Feb 10 12:42:38 kueche volumio[24685]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Feb 10 12:42:38 kueche volumio[24685]: info: CoreStateMachine::setRepeat null single undefined Feb 10 12:42:38 kueche volumio[24685]: info: CoreStateMachine::pushState Feb 10 12:42:38 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:38 kueche volumio[24685]: info: CoreStateMachine::setRandom null Feb 10 12:42:38 kueche volumio[24685]: info: CoreStateMachine::pushState Feb 10 12:42:38 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:38 kueche volumio[24685]: info: Setting Device type: Raspberry PI Feb 10 12:42:38 kueche volumio[24685]: info: DAC script executed Feb 10 12:42:38 kueche volumio[24685]: info: Completed loading Core Plugins Feb 10 12:42:38 kueche volumio[24685]: info: Preparing to generate the ALSA configuration file Feb 10 12:42:38 kueche volumio[24685]: info: VolumeController:: Volume=100 Mute =false Feb 10 12:42:38 kueche volumio[24685]: info: CoreStateMachine::pushState Feb 10 12:42:38 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:38 kueche volumio[24685]: info: CoreStateMachine::updateTrackBlock Feb 10 12:42:38 kueche volumio[24685]: info: CorePlayQueue::getTrackBlock Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::volumioRetrievevolume Feb 10 12:42:38 kueche volumio[24685]: info: Asound.conf file unchanged, so no further update is needed Feb 10 12:42:38 kueche volumio[24685]: info: Output device has changed, restarting MPD Feb 10 12:42:38 kueche sudo[24798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 10 12:42:38 kueche sudo[24798]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:38 kueche sudo[24798]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:38 kueche volumio[24685]: info: Output device has changed, restarting Shairport Sync Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:38 kueche sudo[24801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 10 12:42:38 kueche sudo[24801]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:38 kueche systemd[1]: Stopping Music Player Daemon... Feb 10 12:42:38 kueche systemd[1]: mpd.service: Succeeded. Feb 10 12:42:38 kueche systemd[1]: Stopped Music Player Daemon. Feb 10 12:42:38 kueche volumio[24685]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 10 12:42:38 kueche volumio[24685]: info: ___________ START PLUGINS ___________ Feb 10 12:42:38 kueche volumio[24685]: info: ControllerMpd::onStart: Initializing MPD Feb 10 12:42:38 kueche volumio[24685]: info: Creating MPD Configuration file Feb 10 12:42:38 kueche sudo[24808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 10 12:42:38 kueche sudo[24808]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:38 kueche systemd[1]: Starting Music Player Daemon... Feb 10 12:42:38 kueche sudo[24808]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:38 kueche sudo[24811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 10 12:42:38 kueche sudo[24811]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 10 12:42:38 kueche volumio[24685]: info: [1770723758784] CoreMusicLibrary::Adding element Medienserver Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 12:42:38 kueche systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 10 12:42:38 kueche systemd[1]: mpd.service: Succeeded. Feb 10 12:42:38 kueche systemd[1]: Stopped Music Player Daemon. Feb 10 12:42:38 kueche volumio[24685]: Starting albumart workers Feb 10 12:42:38 kueche volumio[24685]: Starting albumart workers Feb 10 12:42:38 kueche volumio[24685]: Starting albumart workers Feb 10 12:42:38 kueche systemd[1]: Starting Music Player Daemon... Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:38 kueche volumio[24685]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:38 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:38 kueche sudo[24813]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 10 12:42:39 kueche sudo[24813]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:39 kueche sudo[24813]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:39 kueche volumio[24685]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 10 12:42:39 kueche volumio[24685]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 10 12:42:39 kueche volumio[24685]: info: [1770723759147] CoreMusicLibrary::Adding element Last_100 Feb 10 12:42:39 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 12:42:39 kueche volumio[24685]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 10 12:42:39 kueche volumio[24685]: info: [1770723759151] CoreMusicLibrary::Adding element Webradio Feb 10 12:42:39 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 12:42:39 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 12:42:39 kueche volumio[24685]: info: Initializing BBC Radios Feb 10 12:42:39 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 12:42:39 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:39 kueche volumio[24685]: info: [squeezelite_mc] Starting proxy server... Feb 10 12:42:39 kueche volumio[24685]: info: Volumio Calling Home Feb 10 12:42:39 kueche volumio[24685]: info: [squeezelite_mc] Proxy server started on port 39465 Feb 10 12:42:39 kueche volumio[24685]: info: CoreCommandRouter::volumioRetrievevolume Feb 10 12:42:39 kueche volumio[24685]: info: Discovery: adding a0d54c44-6986-4ca3-a5a9-17977cbd4fa7 Feb 10 12:42:39 kueche volumio[24685]: info: Discovery: Found device wohnen Feb 10 12:42:39 kueche volumio[24685]: info: Discovery: Connecting to remote: 192.168.178.39 Feb 10 12:42:39 kueche volumio[24685]: info: Discovery: adding 0dd56c15-94b0-48be-b72c-b626c1510ee3 Feb 10 12:42:39 kueche volumio[24685]: info: Discovery: Found device kueche Feb 10 12:42:39 kueche volumio[24685]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:39 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:39 kueche volumio[24685]: info: MPD Permissions set Feb 10 12:42:39 kueche volumio[24685]: info: MPD Permissions set Feb 10 12:42:40 kueche volumio[24685]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 10 12:42:40 kueche volumio[24685]: info: VolumeController:: Volume=100 Mute =false Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:40 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:40 kueche volumio[24685]: info: CoreStateMachine::pushState Feb 10 12:42:40 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: Volumio called home Feb 10 12:42:40 kueche volumio[24685]: info: VolumeController:: Volume=100 Mute =false Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:40 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:40 kueche volumio[24685]: info: CoreStateMachine::pushState Feb 10 12:42:40 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:40 kueche volumio[24685]: info: [squeezelite_mc] Server discovery started Feb 10 12:42:40 kueche volumio[24685]: info: [squeezelite_mc] Player finder started Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 12:42:40 kueche volumio[24685]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 10 12:42:40 kueche volumio[24685]: info: [squeezelite_mc] Card 2 supports the following ALSA formats: ["S16_LE","S24_LE","S32_LE"] Feb 10 12:42:40 kueche volumio[24685]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"kueche","dsdFormat":null,"card":"2","mixerType":"Hardware","mixer":"Digital"} Feb 10 12:42:40 kueche volumio[24685]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Feb 10 12:42:40 kueche volumio[24685]: info: Starting Shairport Sync Feb 10 12:42:40 kueche volumio[24685]: info: Starting Shairport Sync Feb 10 12:42:40 kueche sudo[24876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 10 12:42:40 kueche sudo[24876]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:40 kueche volumio[24685]: info: Starting Shairport Sync Feb 10 12:42:40 kueche sudo[24879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 10 12:42:40 kueche sudo[24879]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:40 kueche systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 10 12:42:40 kueche sudo[24874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Feb 10 12:42:40 kueche systemd[1]: shairport-sync.service: Succeeded. Feb 10 12:42:40 kueche sudo[24874]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:40 kueche systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 10 12:42:40 kueche sudo[24882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 10 12:42:40 kueche sudo[24882]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:40 kueche sudo[24874]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:40 kueche volumio[24685]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:40 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:40 kueche volumio[24685]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Feb 10 12:42:40 kueche systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 10 12:42:40 kueche sudo[24876]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:40 kueche mpd[24819]: Feb 10 12:42 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 10 12:42:40 kueche sudo[24879]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:40 kueche systemd[1]: Started Music Player Daemon. Feb 10 12:42:40 kueche sudo[24811]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:40 kueche sudo[24801]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:40 kueche sudo[24888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Feb 10 12:42:40 kueche systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 10 12:42:40 kueche sudo[24888]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:40 kueche systemd[1]: shairport-sync.service: Succeeded. Feb 10 12:42:40 kueche systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 10 12:42:40 kueche systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 10 12:42:40 kueche sudo[24882]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:40 kueche sudo[24888]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:40 kueche volumio[24685]: info: Shairport-Sync Started Feb 10 12:42:40 kueche volumio[24685]: Error adding Membership: Error: addMembership EINVAL Feb 10 12:42:40 kueche volumio[24685]: info: Shairport-Sync Started Feb 10 12:42:40 kueche volumio[24685]: info: Shairport-Sync Started Feb 10 12:42:40 kueche volumio[24685]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Feb 10 12:42:40 kueche volumio[24685]: error: MPD error: The expression evaluated to a falsy value: Feb 10 12:42:40 kueche volumio[24685]: assert.ok(self.idling) Feb 10 12:42:40 kueche volumio[24685]: error: The expression evaluated to a falsy value: Feb 10 12:42:40 kueche volumio[24685]: assert.ok(self.idling) Feb 10 12:42:40 kueche sudo[24898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Feb 10 12:42:40 kueche sudo[24898]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:40 kueche sudo[24898]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:40 kueche volumio[24685]: info: MPD running with PID24819 Feb 10 12:42:40 kueche volumio[24685]: ,establishing connection Feb 10 12:42:40 kueche volumio[24685]: error: updateQueue error: null Feb 10 12:42:40 kueche volumio[24685]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Feb 10 12:42:41 kueche volumio[24685]: error: updateQueue error: null Feb 10 12:42:41 kueche sudo[24904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Feb 10 12:42:41 kueche sudo[24904]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:41 kueche systemd[1]: Reloading. Feb 10 12:42:41 kueche systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 10 12:42:41 kueche volumio[24685]: info: [squeezelite_mc] Server discovered: {"ip":"192.168.178.39","name":"wohnen","ver":"7.9.1","uuid":"7e93b266-dc04-408a-8f9b-46ec781f5644","jsonPort":"9000","cliPort":"9090"} Feb 10 12:42:41 kueche volumio[24685]: info: [yt-cast-receiver] DIAL server listening on port 8098 Feb 10 12:42:41 kueche sudo[24904]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:41 kueche sudo[24934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 10 12:42:41 kueche sudo[24934]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:41 kueche sudo[24934]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:41 kueche volumio[24685]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Feb 10 12:42:41 kueche sudo[24937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 10 12:42:41 kueche sudo[24937]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:41 kueche sudo[24937]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:41 kueche sudo[24940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Feb 10 12:42:41 kueche sudo[24940]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:41 kueche sudo[24943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 10 12:42:41 kueche sudo[24943]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:41 kueche sudo[24940]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:41 kueche sudo[24943]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:41 kueche volumio[24685]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true Feb 10 12:42:41 kueche volumio[24685]: info: Upmpdcli Daemon Started Feb 10 12:42:41 kueche sudo[24947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite Feb 10 12:42:41 kueche sudo[24947]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:42 kueche systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Feb 10 12:42:42 kueche volumio[24685]: info: Discovery: Connected to remote: 192.168.178.39 Feb 10 12:42:42 kueche systemd[1]: squeezelite.service: Succeeded. Feb 10 12:42:42 kueche systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Feb 10 12:42:42 kueche sudo[24947]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:42 kueche volumio[24685]: info: [squeezelite_mc] Notification listener started Feb 10 12:42:42 kueche volumio[24685]: info: [squeezelite_mc] Getting players connected to wohnen (192.168.178.39) Feb 10 12:42:42 kueche volumio[24685]: info: [squeezelite_mc] Players connected to wohnen (192.168.178.39): [{"id":"b8:27:eb:05:40:64","uuid":null,"ip":"192.168.178.39","name":"Wohnen","server":{"ip":"192.168.178.39","name":"wohnen","ver":"7.9.1","uuid":"7e93b266-dc04-408a-8f9b-46ec781f5644","jsonPort":"9000","cliPort":"9090"}}] Feb 10 12:42:42 kueche volumio[24685]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Feb 10 12:42:42 kueche sudo[24950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Feb 10 12:42:42 kueche sudo[24950]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:42 kueche sudo[24950]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:42 kueche volumio[24685]: info: [squeezelite_mc] Executing rm /tmp/squeezelite.log Feb 10 12:42:42 kueche sudo[24954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /tmp/squeezelite.log Feb 10 12:42:42 kueche sudo[24954]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:42 kueche sudo[24954]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:42 kueche volumio[24685]: info: Cannot mount NAS Fritz at system boot, trial number 3 ,retrying in 5 seconds Feb 10 12:42:42 kueche volumio[24685]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true Feb 10 12:42:42 kueche sudo[24957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Feb 10 12:42:42 kueche sudo[24957]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:43 kueche systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Feb 10 12:42:43 kueche systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Feb 10 12:42:43 kueche sudo[24957]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:43 kueche volumio[24685]: info: [squeezelite_mc] 'client' notification received from wohnen (192.168.178.39); type is 'connect' Feb 10 12:42:43 kueche volumio[24685]: info: [squeezelite_mc] Getting players connected to wohnen (192.168.178.39) Feb 10 12:42:43 kueche volumio[24685]: info: [squeezelite_mc] Players connected to wohnen (192.168.178.39): [{"id":"b8:27:eb:b1:b2:d6","uuid":null,"ip":"192.168.178.73","name":"kueche","server":{"ip":"192.168.178.39","name":"wohnen","ver":"7.9.1","uuid":"7e93b266-dc04-408a-8f9b-46ec781f5644","jsonPort":"9000","cliPort":"9090"}},{"id":"b8:27:eb:05:40:64","uuid":null,"ip":"192.168.178.39","name":"Wohnen","server":{"ip":"192.168.178.39","name":"wohnen","ver":"7.9.1","uuid":"7e93b266-dc04-408a-8f9b-46ec781f5644","jsonPort":"9000","cliPort":"9090"}}] Feb 10 12:42:43 kueche volumio[24685]: info: [squeezelite_mc] Player found: {"id":"b8:27:eb:b1:b2:d6","uuid":null,"ip":"192.168.178.73","name":"kueche","server":{"ip":"192.168.178.39","name":"wohnen","ver":"7.9.1","uuid":"7e93b266-dc04-408a-8f9b-46ec781f5644","jsonPort":"9000","cliPort":"9090"}} Feb 10 12:42:43 kueche volumio[24685]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Feb 10 12:42:43 kueche sudo[24964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Feb 10 12:42:43 kueche sudo[24964]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:43 kueche sudo[24964]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:44 kueche volumio[24685]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Feb 10 12:42:44 kueche sudo[24967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Feb 10 12:42:44 kueche sudo[24967]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:44 kueche sudo[24967]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:44 kueche volumio[24685]: info: [squeezelite_mc] Squeezelite in sync group with sync master b8:27:eb:05:40:64. Feb 10 12:42:44 kueche volumio[24685]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:44 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:42:44 kueche volumio[24685]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Feb 10 12:42:44 kueche sudo[24970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Feb 10 12:42:44 kueche sudo[24970]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:44 kueche sudo[24970]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:45 kueche volumio[24685]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Feb 10 12:42:45 kueche sudo[24973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Feb 10 12:42:45 kueche sudo[24973]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:45 kueche sudo[24973]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:45 kueche volumio[24685]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Feb 10 12:42:45 kueche sudo[24976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Feb 10 12:42:45 kueche sudo[24976]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:45 kueche sudo[24976]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:45 kueche volumio[24685]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 10 12:42:45 kueche volumio[24685]: info: Completed starting Core Plugins Feb 10 12:42:45 kueche volumio[24685]: info: ------------------------------------------- Feb 10 12:42:45 kueche volumio[24685]: info: ----- MyVolumio plugins startup ---- Feb 10 12:42:45 kueche volumio[24685]: info: ------------------------------------------- Feb 10 12:42:45 kueche volumio[24685]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 10 12:42:47 kueche volumio[24685]: info: Cannot mount NAS Fritz at system boot, trial number 4 ,retrying in 5 seconds Feb 10 12:42:52 kueche volumio[24685]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 10 12:42:54 kueche volumio[24685]: info: Adding plugin bluetooth to MyMusic Plugins Feb 10 12:42:54 kueche volumio[24685]: info: Adding plugin multiroom to MyMusic Plugins Feb 10 12:42:54 kueche volumio[24685]: info: Adding plugin metavolumio to MyMusic Plugins Feb 10 12:42:54 kueche volumio[24685]: info: Adding plugin cd_controller to MyMusic Plugins Feb 10 12:42:54 kueche volumio[24685]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 10 12:42:54 kueche volumio[24685]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 10 12:42:54 kueche volumio[24685]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 10 12:42:54 kueche volumio[24685]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 10 12:42:55 kueche volumio[24685]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 10 12:42:55 kueche volumio[24685]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 10 12:42:55 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:42:55 kueche volumio[24685]: info: Starting MyVolumio Remote Streaming Endpoints Feb 10 12:42:55 kueche volumio[24685]: info: MyVolumio login type: Token Feb 10 12:42:55 kueche volumio[24685]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 10 12:42:55 kueche volumio[24685]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 10 12:42:56 kueche volumio[24685]: info: Starting Streaming Service Transparent Proxy Feb 10 12:42:56 kueche volumio[24685]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 10 12:42:56 kueche volumio[24685]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 10 12:42:56 kueche volumio[24685]: info: Streaming services startup Feb 10 12:42:56 kueche volumio[24685]: info: Starting Streaming Daemon Feb 10 12:42:56 kueche sudo[25003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 10 12:42:56 kueche sudo[25003]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:42:56 kueche sudo[25003]: pam_unix(sudo:session): session closed for user root Feb 10 12:42:56 kueche dhcpcd[873]: eth0: carrier lost Feb 10 12:42:56 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: kevent 4 may have been dropped Feb 10 12:42:56 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: kevent 4 may have been dropped Feb 10 12:42:56 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: kevent 4 may have been dropped Feb 10 12:42:56 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: kevent 4 may have been dropped Feb 10 12:42:56 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: kevent 4 may have been dropped Feb 10 12:42:56 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Down Feb 10 12:42:56 kueche volumio[24685]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 10 12:42:56 kueche volumio[24685]: error: Cannot start Volumio Streaming Daemon Feb 10 12:42:56 kueche volumio[24685]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 10 12:42:56 kueche volumio[24685]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 10 12:42:56 kueche ifplugd(eth0)[744]: Link beat lost. Feb 10 12:42:56 kueche dhcpcd[873]: eth0: deleting route to 192.168.178.0/24 Feb 10 12:42:56 kueche dhcpcd[873]: eth0: deleting default route via 192.168.178.1 Feb 10 12:42:56 kueche avahi-daemon[539]: Withdrawing address record for 192.168.178.73 on eth0. Feb 10 12:42:56 kueche avahi-daemon[539]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.178.73. Feb 10 12:42:56 kueche avahi-daemon[539]: Interface eth0.IPv4 no longer relevant for mDNS. Feb 10 12:42:56 kueche volumio[24685]: info: Discovery: A device disappeared from network Feb 10 12:42:56 kueche volumio[24685]: info: Discovery: Device kueche disappeared from network Feb 10 12:42:56 kueche volumio[24685]: info: Discovery: A device disappeared from network Feb 10 12:42:56 kueche volumio[24685]: info: Discovery: Device wohnen disappeared from network Feb 10 12:42:56 kueche volumio[24685]: info: Discovery: Disconnected from remote: 192.168.178.39 Feb 10 12:42:56 kueche ntpd[24708]: ntpd exiting on signal 15 (Terminated) Feb 10 12:42:56 kueche ntpd[24708]: 192.168.178.1 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 185.252.140.125 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 139.162.152.20 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 162.159.200.1 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 85.220.190.246 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 148.251.235.164 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 176.9.42.91 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 142.132.200.241 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 88.99.86.9 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 128.140.109.119 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 129.70.132.36 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 136.243.7.20 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 93.241.86.156 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 81.169.233.252 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 46.21.2.169 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 46.224.156.215 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche ntpd[24708]: 93.177.65.20 local addr 192.168.178.73 -> Feb 10 12:42:56 kueche systemd[1]: Stopping Network Time Service... Feb 10 12:42:56 kueche systemd[1]: ntp.service: Succeeded. Feb 10 12:42:56 kueche systemd[1]: Stopped Network Time Service. Feb 10 12:42:56 kueche systemd[1]: Starting Network Time Service... Feb 10 12:42:56 kueche ntpd[25053]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 10 12:42:56 kueche ntpd[25053]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Feb 10 12:42:56 kueche systemd[1]: Started Network Time Service. Feb 10 12:42:56 kueche ntpd[25059]: proto: precision = 0.625 usec (-21) Feb 10 12:42:56 kueche ntpd[25059]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 10 12:42:56 kueche ntpd[25059]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 10 12:42:56 kueche ntpd[25059]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 410 days ago Feb 10 12:42:56 kueche ntpd[25059]: Listen and drop on 0 v6wildcard [::]:123 Feb 10 12:42:56 kueche ntpd[25059]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 10 12:42:56 kueche ntpd[25059]: Listen normally on 2 lo 127.0.0.1:123 Feb 10 12:42:56 kueche ntpd[25059]: Listening on routing socket on fd #19 for interface updates Feb 10 12:42:56 kueche ntpd[25059]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:42:56 kueche ntpd[25059]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:42:57 kueche volumio[24685]: STREAMING PROXY: Starting server on port 3245 Feb 10 12:42:57 kueche volumio[24685]: Node JS runtime: 14 Feb 10 12:42:57 kueche ntpd[25059]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 10 12:42:58 kueche dhcpcd[873]: eth0: carrier acquired Feb 10 12:42:58 kueche dhcpcd[873]: eth0: IAID eb:b1:b2:d6 Feb 10 12:42:58 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Feb 10 12:42:58 kueche ifplugd(eth0)[744]: Link beat detected. Feb 10 12:42:58 kueche dhcpcd[873]: eth0: soliciting an IPv6 router Feb 10 12:42:58 kueche dhcpcd[873]: eth0: rebinding lease of 192.168.178.73 Feb 10 12:42:58 kueche dhcpcd[873]: eth0: probing address 192.168.178.73/24 Feb 10 12:42:58 kueche ntpd[25059]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 10 12:42:59 kueche ntpd[25059]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 10 12:43:00 kueche ntpd[25059]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 10 12:43:01 kueche volumio[24685]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Feb 10 12:43:01 kueche volumio[24685]: info: Retrying Login Due to Network Error Feb 10 12:43:01 kueche volumio[24685]: info: Volumio Network Manager: Network status updated: 0 Feb 10 12:43:03 kueche dhcpcd[873]: eth0: leased 192.168.178.73 for 864000 seconds Feb 10 12:43:03 kueche dhcpcd[873]: eth0: adding route to 192.168.178.0/24 Feb 10 12:43:03 kueche dhcpcd[873]: eth0: adding default route via 192.168.178.1 Feb 10 12:43:03 kueche avahi-daemon[539]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.178.73. Feb 10 12:43:03 kueche avahi-daemon[539]: New relevant interface eth0.IPv4 for mDNS. Feb 10 12:43:03 kueche avahi-daemon[539]: Registering new address record for 192.168.178.73 on eth0.IPv4. Feb 10 12:43:03 kueche ntpd[25059]: ntpd exiting on signal 15 (Terminated) Feb 10 12:43:03 kueche systemd[1]: Stopping Network Time Service... Feb 10 12:43:03 kueche systemd[1]: ntp.service: Succeeded. Feb 10 12:43:03 kueche systemd[1]: Stopped Network Time Service. Feb 10 12:43:03 kueche systemd[1]: Starting Network Time Service... Feb 10 12:43:03 kueche ntpd[25108]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 10 12:43:03 kueche ntpd[25108]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Feb 10 12:43:03 kueche systemd[1]: Started Network Time Service. Feb 10 12:43:03 kueche ntpd[25115]: proto: precision = 0.625 usec (-21) Feb 10 12:43:03 kueche ntpd[25115]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 10 12:43:03 kueche ntpd[25115]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 10 12:43:03 kueche ntpd[25115]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 410 days ago Feb 10 12:43:03 kueche ntpd[25115]: Listen and drop on 0 v6wildcard [::]:123 Feb 10 12:43:03 kueche ntpd[25115]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 10 12:43:03 kueche ntpd[25115]: Listen normally on 2 lo 127.0.0.1:123 Feb 10 12:43:03 kueche ntpd[25115]: Listen normally on 3 eth0 192.168.178.73:123 Feb 10 12:43:03 kueche ntpd[25115]: Listening on routing socket on fd #20 for interface updates Feb 10 12:43:03 kueche ntpd[25115]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:43:03 kueche ntpd[25115]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:43:03 kueche volumio[24685]: info: Discovery: adding a0d54c44-6986-4ca3-a5a9-17977cbd4fa7 Feb 10 12:43:03 kueche volumio[24685]: info: Discovery: Found device wohnen Feb 10 12:43:03 kueche volumio[24685]: info: Discovery: Connecting to remote: 192.168.178.39 Feb 10 12:43:04 kueche volumio[24685]: info: Discovery: Connected to remote: 192.168.178.39 Feb 10 12:43:04 kueche volumio[24685]: info: Discovery: adding 0dd56c15-94b0-48be-b72c-b626c1510ee3 Feb 10 12:43:04 kueche volumio[24685]: info: Discovery: Found device kueche Feb 10 12:43:04 kueche volumio[24685]: info: CoreCommandRouter::volumioGetState Feb 10 12:43:04 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:43:04 kueche ntpd[25115]: Soliciting pool server 185.252.140.125 Feb 10 12:43:05 kueche ntpd[25115]: Soliciting pool server 139.162.152.20 Feb 10 12:43:05 kueche ntpd[25115]: Soliciting pool server 162.159.200.1 Feb 10 12:43:06 kueche ntpd[25115]: Soliciting pool server 148.251.235.164 Feb 10 12:43:06 kueche ntpd[25115]: Soliciting pool server 85.220.190.246 Feb 10 12:43:06 kueche ntpd[25115]: Soliciting pool server 194.59.205.229 Feb 10 12:43:07 kueche ntpd[25115]: Soliciting pool server 134.60.1.27 Feb 10 12:43:07 kueche ntpd[25115]: Soliciting pool server 142.132.200.241 Feb 10 12:43:07 kueche ntpd[25115]: Soliciting pool server 88.99.86.9 Feb 10 12:43:07 kueche ntpd[25115]: Soliciting pool server 128.140.109.119 Feb 10 12:43:08 kueche ntpd[25115]: Soliciting pool server 93.241.86.156 Feb 10 12:43:08 kueche ntpd[25115]: Soliciting pool server 82.165.178.31 Feb 10 12:43:08 kueche ntpd[25115]: Soliciting pool server 81.169.233.252 Feb 10 12:43:09 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 12:43:09 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:09 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 10 12:43:09 kueche ntpd[25115]: Soliciting pool server 46.21.2.169 Feb 10 12:43:09 kueche ntpd[25115]: Soliciting pool server 2a01:239:25e:bd00::4 Feb 10 12:43:09 kueche volumio-remote-updater[27958]: No test mode Feb 10 12:43:09 kueche volumio-remote-updater[27958]: No alpha test mode Feb 10 12:43:09 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 10 12:43:09 kueche volumio[24685]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

    • Fix for BT connection requests

 

NEW ADDITIONS

    • BLE-based onboarding setup
    • Update Tidal SDK

 

","title":"Update v3.908","updateavailable":true} Feb 10 12:43:09 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 10 12:43:10 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 10 12:43:10 kueche volumio[24685]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 10 12:43:10 kueche volumio[24685]: info: CoreCommandRouter::volumioGetState Feb 10 12:43:10 kueche volumio[24685]: info: CorePlayQueue::getTrack 0 Feb 10 12:43:10 kueche ntpd[25115]: Soliciting pool server 93.177.65.20 Feb 10 12:43:11 kueche volumio[24685]: info: MyVolumio login type: Token Feb 10 12:43:11 kueche volumio[24685]: info: Volumio Network Manager: Network status updated: 1 Feb 10 12:43:12 kueche volumio[24685]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 10 12:43:12 kueche volumio[24685]: info: MyVolumio token set successfully Feb 10 12:43:12 kueche volumio[24685]: info: MYVOLUMIO: Adding device Feb 10 12:43:12 kueche volumio[24685]: info: MYVOLUMIO: Evaluating Server Feb 10 12:43:13 kueche volumio[24685]: info: MyVolumio status changed Feb 10 12:43:13 kueche volumio[24685]: info: Streaming services startup Feb 10 12:43:13 kueche volumio[24685]: info: Starting Streaming Daemon Feb 10 12:43:13 kueche volumio[24685]: info: Removing browser output: myVolumio user plan is not superstar Feb 10 12:43:13 kueche volumio[24685]: info: Removing audio output: Feb 10 12:43:13 kueche volumio[24685]: info: Stoppping Tunnel 1 Feb 10 12:43:13 kueche sudo[25156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 10 12:43:13 kueche sudo[25156]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:43:13 kueche sudo[25156]: pam_unix(sudo:session): session closed for user root Feb 10 12:43:13 kueche sudo[25159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Feb 10 12:43:13 kueche sudo[25159]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:43:13 kueche volumio[24685]: error: Cannot start Volumio Streaming Daemon Feb 10 12:43:13 kueche volumio[24685]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 10 12:43:13 kueche volumio[24685]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 10 12:43:13 kueche sudo[25159]: pam_unix(sudo:session): session closed for user root Feb 10 12:43:13 kueche volumio[24685]: info: Remote SSH Stopped Feb 10 12:43:15 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:43:15 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:43:15 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 10 12:43:15 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 10 12:43:15 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 10 12:43:15 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 10 12:43:15 kueche volumio[24685]: info: CoreCommandRouter::volumioGetBrowseSources Feb 10 12:43:15 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 12:43:16 kueche volumio[24685]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 10 12:43:16 kueche volumio[24685]: info: Completed starting MyVolumio Plugin Feb 10 12:43:16 kueche volumio[24685]: [Metrics] CommandRouter: 46s 556.33ms Feb 10 12:43:16 kueche volumio[24685]: info: CoreCommandRouter::volumiosetStartupVolume Feb 10 12:43:16 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 12:43:16 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:16 kueche volumio[24685]: info: CoreCommandRouter::Close All Modals sent Feb 10 12:43:16 kueche volumio[24685]: info: CoreCommandRouter::Close All Modals sent Feb 10 12:43:17 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 10 12:43:17 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 10 12:43:17 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 10 12:43:17 kueche volumio[24685]: info: Setting Geolocation for MyVolumio to eu7 Feb 10 12:43:17 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:17 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:17 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:18 kueche volumio[24685]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 10 12:43:18 kueche volumio[24685]: info: Updating MyVolumio device info Feb 10 12:43:18 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:18 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:18 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:19 kueche volumio[24685]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 10 12:43:22 kueche volumio[24685]: info: MYVOLUMIO: Adding device Feb 10 12:43:22 kueche volumio[24685]: info: MYVOLUMIO: Evaluating Server Feb 10 12:43:23 kueche volumio[24685]: info: Setting Geolocation for MyVolumio to eu4 Feb 10 12:43:23 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:23 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:23 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:23 kueche volumio[24685]: info: BOOT COMPLETED Feb 10 12:43:23 kueche volumio[24685]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 10 12:43:24 kueche volumio[24685]: info: Updating MyVolumio device info Feb 10 12:43:24 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:24 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:24 kueche volumio[24685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 12:43:24 kueche volumio[24685]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 10 12:43:32 kueche dhcpcd[873]: eth0: carrier lost Feb 10 12:43:32 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Down Feb 10 12:43:32 kueche dhcpcd[873]: eth0: deleting route to 192.168.178.0/24 Feb 10 12:43:32 kueche dhcpcd[873]: eth0: deleting default route via 192.168.178.1 Feb 10 12:43:32 kueche avahi-daemon[539]: Withdrawing address record for 192.168.178.73 on eth0. Feb 10 12:43:32 kueche avahi-daemon[539]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.178.73. Feb 10 12:43:32 kueche avahi-daemon[539]: Interface eth0.IPv4 no longer relevant for mDNS. Feb 10 12:43:32 kueche volumio[24685]: info: Discovery: A device disappeared from network Feb 10 12:43:32 kueche volumio[24685]: info: Discovery: Device kueche disappeared from network Feb 10 12:43:32 kueche volumio[24685]: info: Discovery: A device disappeared from network Feb 10 12:43:32 kueche volumio[24685]: info: Discovery: Device wohnen disappeared from network Feb 10 12:43:32 kueche volumio[24685]: info: Discovery: Disconnected from remote: 192.168.178.39 Feb 10 12:43:32 kueche ntpd[25115]: ntpd exiting on signal 15 (Terminated) Feb 10 12:43:32 kueche ntpd[25115]: 192.168.178.1 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche systemd[1]: Stopping Network Time Service... Feb 10 12:43:32 kueche ntpd[25115]: 185.252.140.125 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche systemd[1]: ntp.service: Succeeded. Feb 10 12:43:32 kueche ntpd[25115]: 139.162.152.20 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 162.159.200.1 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 85.220.190.246 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 148.251.235.164 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 194.59.205.229 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche systemd[1]: Stopped Network Time Service. Feb 10 12:43:32 kueche ntpd[25115]: 134.60.1.27 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 142.132.200.241 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 88.99.86.9 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 128.140.109.119 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 82.165.178.31 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 93.241.86.156 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 81.169.233.252 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 46.21.2.169 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche ntpd[25115]: 93.177.65.20 local addr 192.168.178.73 -> Feb 10 12:43:32 kueche systemd[1]: Starting Network Time Service... Feb 10 12:43:32 kueche ntpd[25294]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 10 12:43:32 kueche ntpd[25294]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Feb 10 12:43:32 kueche systemd[1]: Started Network Time Service. Feb 10 12:43:32 kueche ntpd[25300]: proto: precision = 0.573 usec (-21) Feb 10 12:43:32 kueche ntpd[25300]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 10 12:43:32 kueche ntpd[25300]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 10 12:43:32 kueche ntpd[25300]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 410 days ago Feb 10 12:43:32 kueche ntpd[25300]: Listen and drop on 0 v6wildcard [::]:123 Feb 10 12:43:32 kueche ntpd[25300]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 10 12:43:32 kueche ntpd[25300]: Listen normally on 2 lo 127.0.0.1:123 Feb 10 12:43:32 kueche ntpd[25300]: Listening on routing socket on fd #19 for interface updates Feb 10 12:43:32 kueche ntpd[25300]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:43:32 kueche ntpd[25300]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Feb 10 12:43:32 kueche ifplugd(eth0)[744]: Link beat lost. Feb 10 12:43:33 kueche ntpd[25300]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 10 12:43:34 kueche ntpd[25300]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 10 12:43:34 kueche ifplugd(eth0)[744]: Link beat detected. Feb 10 12:43:35 kueche dhcpcd[873]: eth0: carrier acquired Feb 10 12:43:35 kueche kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Feb 10 12:43:35 kueche dhcpcd[873]: eth0: IAID eb:b1:b2:d6 Feb 10 12:43:35 kueche dhcpcd[873]: eth0: rebinding lease of 192.168.178.73 Feb 10 12:43:35 kueche dhcpcd[873]: eth0: probing address 192.168.178.73/24 Feb 10 12:43:35 kueche ntpd[25300]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 10 12:43:36 kueche dhcpcd[873]: eth0: soliciting an IPv6 router Feb 10 12:43:36 kueche ntpd[25300]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 10 12:43:40 kueche volumio[24685]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 12:43:40 kueche volumio[24685]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 10 12:43:40 kueche volumio[24685]: at doSend (dgram.js:692:16) Feb 10 12:43:40 kueche volumio[24685]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 10 12:43:40 kueche volumio[24685]: at afterDns (dgram.js:638:5) Feb 10 12:43:40 kueche volumio[24685]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 10 12:43:40 kueche volumio[24685]: errno: -101, Feb 10 12:43:40 kueche volumio[24685]: code: 'ENETUNREACH', Feb 10 12:43:40 kueche volumio[24685]: syscall: 'send', Feb 10 12:43:40 kueche volumio[24685]: address: '255.255.255.255', Feb 10 12:43:40 kueche volumio[24685]: port: 3483 Feb 10 12:43:40 kueche volumio[24685]: } Feb 10 12:43:40 kueche volumio[24685]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 12:43:40 kueche dhcpcd[873]: eth0: leased 192.168.178.73 for 864000 seconds Feb 10 12:43:40 kueche dhcpcd[873]: eth0: adding route to 192.168.178.0/24 Feb 10 12:43:40 kueche dhcpcd[873]: eth0: adding default route via 192.168.178.1 Feb 10 12:43:40 kueche avahi-daemon[539]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.178.73. Feb 10 12:43:40 kueche avahi-daemon[539]: New relevant interface eth0.IPv4 for mDNS. Feb 10 12:43:40 kueche avahi-daemon[539]: Registering new address record for 192.168.178.73 on eth0.IPv4. Feb 10 12:43:40 kueche sudo[25328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-10 12:42 Feb 10 12:43:40 kueche sudo[25328]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 12:43:41 kueche ntpd[25300]: ntpd exiting on signal 15 (Terminated) Feb 10 12:43:41 kueche systemd[1]: Stopping Network Time Service... Feb 10 12:43:41 kueche systemd[1]: ntp.service: Succeeded. Feb 10 12:43:41 kueche systemd[1]: Stopped Network Time Service. 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"