-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2026-10-12 04:01:51 CEST. -- Oct 12 04:00:03 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:00:03 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:00:13 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:00:13 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:00:13 music-player-teun volumio[918]: info: Listing playlists Oct 12 04:00:13 music-player-teun volumio[918]: info: Listing playlists Oct 12 04:00:23 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:00:23 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:00:33 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:00:33 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:00:33 music-player-teun volumio[918]: info: Listing playlists Oct 12 04:00:33 music-player-teun volumio[918]: info: Listing playlists Oct 12 04:00:43 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:00:43 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:00:52 music-player-teun volumiologrotate[604]: ls: cannot access '/var/log/samba/log.wb-MUSIC': No such file or directory Oct 12 04:00:52 music-player-teun volumiologrotate[604]: ls: cannot access 'PLAYER': No such file or directory Oct 12 04:00:52 music-player-teun volumiologrotate[604]: ls: cannot access 'TEUN': No such file or directory Oct 12 04:00:53 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:00:53 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:00:53 music-player-teun volumio[918]: info: Listing playlists Oct 12 04:00:53 music-player-teun volumio[918]: info: Listing playlists Oct 12 04:01:03 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:03 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:10 music-player-teun dhcpcd[935]: eth0: carrier lost Oct 12 04:01:10 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Oct 12 04:01:11 music-player-teun avahi-daemon[620]: Withdrawing address record for 192.168.2.16 on eth0. Oct 12 04:01:11 music-player-teun dhcpcd[935]: eth0: deleting route to 192.168.2.0/24 Oct 12 04:01:11 music-player-teun dhcpcd[935]: eth0: deleting default route via 192.168.2.254 Oct 12 04:01:11 music-player-teun avahi-daemon[620]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.2.16. Oct 12 04:01:11 music-player-teun avahi-daemon[620]: Interface eth0.IPv4 no longer relevant for mDNS. Oct 12 04:01:11 music-player-teun volumio[918]: info: Discovery: A device disappeared from network Oct 12 04:01:11 music-player-teun volumio[918]: info: Discovery: A device disappeared from network Oct 12 04:01:11 music-player-teun volumio[918]: info: Discovery: A device disappeared from network Oct 12 04:01:11 music-player-teun ntpd[934]: ntpd exiting on signal 15 (Terminated) Oct 12 04:01:11 music-player-teun ntpd[934]: 192.168.2.254 local addr 192.168.2.16 -> Oct 12 04:01:11 music-player-teun systemd[1]: Stopping Network Time Service... Oct 12 04:01:11 music-player-teun ntpd[934]: 192.42.116.90 local addr 192.168.2.16 -> Oct 12 04:01:11 music-player-teun ntpd[934]: 5.79.108.34 local addr 192.168.2.16 -> Oct 12 04:01:11 music-player-teun ntpd[934]: 178.239.19.62 local addr 192.168.2.16 -> Oct 12 04:01:11 music-player-teun ntpd[934]: 178.239.19.56 local addr 192.168.2.16 -> Oct 12 04:01:11 music-player-teun ntpd[934]: 178.238.99.189 local addr 192.168.2.16 -> Oct 12 04:01:11 music-player-teun systemd[1]: ntp.service: Succeeded. Oct 12 04:01:11 music-player-teun systemd[1]: Stopped Network Time Service. Oct 12 04:01:11 music-player-teun systemd[1]: Starting Network Time Service... Oct 12 04:01:11 music-player-teun ntpd[18301]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 12 04:01:11 music-player-teun ntpd[18301]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Oct 12 04:01:11 music-player-teun systemd[1]: Started Network Time Service. Oct 12 04:01:11 music-player-teun ntpd[18309]: proto: precision = 0.677 usec (-20) Oct 12 04:01:11 music-player-teun ntpd[18309]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 12 04:01:11 music-player-teun ntpd[18309]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 12 04:01:11 music-player-teun ntpd[18309]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 654 days ago Oct 12 04:01:11 music-player-teun ntpd[18309]: Listen and drop on 0 v6wildcard [::]:123 Oct 12 04:01:11 music-player-teun ntpd[18309]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 12 04:01:11 music-player-teun ntpd[18309]: Listen normally on 2 lo 127.0.0.1:123 Oct 12 04:01:11 music-player-teun ntpd[18309]: Listening on routing socket on fd #19 for interface updates Oct 12 04:01:11 music-player-teun ntpd[18309]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Oct 12 04:01:11 music-player-teun ntpd[18309]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Oct 12 04:01:11 music-player-teun volumio[918]: info: Received Get System Info Oct 12 04:01:11 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 04:01:11 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 04:01:11 music-player-teun volumio[918]: info: Discovery: Getting this device information Oct 12 04:01:11 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:11 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:11 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 04:01:11 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 04:01:11 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 04:01:11 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:11.727+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 04:01:11 music-player-teun ifplugd(eth0)[832]: Link beat lost. Oct 12 04:01:12 music-player-teun ntpd[18309]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Oct 12 04:01:13 music-player-teun ntpd[18309]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 12 04:01:14 music-player-teun ntpd[18309]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Oct 12 04:01:15 music-player-teun ntpd[18309]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 12 04:01:18 music-player-teun volumio[918]: info: Volumio Network Manager: Network status updated: 0 Oct 12 04:01:20 music-player-teun dhcpcd[935]: eth0: carrier acquired Oct 12 04:01:20 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off Oct 12 04:01:20 music-player-teun dhcpcd[935]: eth0: IAID eb:c1:22:22 Oct 12 04:01:20 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Oct 12 04:01:21 music-player-teun dhcpcd[935]: eth0: soliciting an IPv6 router Oct 12 04:01:21 music-player-teun volumio[918]: info: Received Get System Info Oct 12 04:01:21 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 04:01:21 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 04:01:21 music-player-teun volumio[918]: info: Discovery: Getting this device information Oct 12 04:01:21 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:21 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:21 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 04:01:21 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 04:01:21 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 04:01:21 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:21.027+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 04:01:21 music-player-teun dhcpcd[935]: eth0: rebinding lease of 192.168.2.16 Oct 12 04:01:21 music-player-teun dhcpcd[935]: eth0: carrier lost Oct 12 04:01:22 music-player-teun volumio[918]: info: Received Get System Info Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 04:01:22 music-player-teun volumio[918]: info: Discovery: Getting this device information Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:22 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 04:01:22 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:22.032+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 04:01:22 music-player-teun ifplugd(eth0)[832]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Oct 12 04:01:22 music-player-teun ifplugd(eth0)[832]: client: sending signal ALRM to pid 935 Oct 12 04:01:22 music-player-teun dhcpcd[18356]: sending signal ALRM to pid 935 Oct 12 04:01:22 music-player-teun dhcpcd[935]: received SIGALRM, releasing Oct 12 04:01:22 music-player-teun dhcpcd[935]: eth0: removing interface Oct 12 04:01:22 music-player-teun dhcpcd[18356]: waiting for pid 935 to exit Oct 12 04:01:22 music-player-teun ifplugd(eth0)[832]: client: waiting for pid 935 to exit Oct 12 04:01:22 music-player-teun dhcpcd[935]: dhcpcd exited Oct 12 04:01:22 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Oct 12 04:01:22 music-player-teun ifplugd(eth0)[832]: Program executed successfully. Oct 12 04:01:22 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Oct 12 04:01:22 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Oct 12 04:01:22 music-player-teun volumio[918]: info: Received Get System Info Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 04:01:22 music-player-teun volumio[918]: info: Discovery: Getting this device information Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:22 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 04:01:22 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 04:01:23 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:23.032+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 04:01:23 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off Oct 12 04:01:24 music-player-teun volumio[918]: info: Received Get System Info Oct 12 04:01:24 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 04:01:24 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 04:01:24 music-player-teun volumio[918]: info: Discovery: Getting this device information Oct 12 04:01:24 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:24 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:24 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 04:01:24 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 04:01:24 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 04:01:24 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:24.287+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 04:01:24 music-player-teun ifplugd(eth0)[832]: Link beat detected. Oct 12 04:01:24 music-player-teun ifplugd(eth0)[832]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 12 04:01:24 music-player-teun nmbd[805]: [2026/10/12 04:01:24.518476, 0] ../source3/libsmb/nmblib.c:917(send_udp) Oct 12 04:01:24 music-player-teun nmbd[805]: Packet send failed to 192.168.2.255(137) ERRNO=Network is unreachable Oct 12 04:01:24 music-player-teun nmbd[805]: [2026/10/12 04:01:24.518794, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Oct 12 04:01:24 music-player-teun nmbd[805]: send_netbios_packet: send_packet() to IP 192.168.2.255 port 137 failed Oct 12 04:01:24 music-player-teun nmbd[805]: [2026/10/12 04:01:24.518893, 0] ../source3/nmbd/nmbd_namequery.c:245(query_name) Oct 12 04:01:24 music-player-teun nmbd[805]: query_name: Failed to send packet trying to query name WORKGROUP<1d> Oct 12 04:01:24 music-player-teun dhcpcd[18399]: DUID 00:01:00:01:2f:7d:86:a5:b8:27:eb:c1:22:22 Oct 12 04:01:24 music-player-teun dhcpcd[18399]: eth0: IAID eb:c1:22:22 Oct 12 04:01:24 music-player-teun dhcpcd[18399]: eth0: adding address fe80::ba27:ebff:fec1:2222 Oct 12 04:01:24 music-player-teun dhcpcd[18399]: ipv6_addaddr1: Permission denied Oct 12 04:01:24 music-player-teun ifplugd(eth0)[832]: client: DUID 00:01:00:01:2f:7d:86:a5:b8:27:eb:c1:22:22 Oct 12 04:01:24 music-player-teun ifplugd(eth0)[832]: client: eth0: IAID eb:c1:22:22 Oct 12 04:01:24 music-player-teun ifplugd(eth0)[832]: client: eth0: adding address fe80::ba27:ebff:fec1:2222 Oct 12 04:01:24 music-player-teun ifplugd(eth0)[832]: client: ipv6_addaddr1: Permission denied Oct 12 04:01:24 music-player-teun dhcpcd[18399]: eth0: rebinding lease of 192.168.2.16 Oct 12 04:01:24 music-player-teun ifplugd(eth0)[832]: client: eth0: rebinding lease of 192.168.2.16 Oct 12 04:01:25 music-player-teun volumio[918]: info: Received Get System Info Oct 12 04:01:25 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 04:01:25 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 04:01:25 music-player-teun volumio[918]: info: Discovery: Getting this device information Oct 12 04:01:25 music-player-teun volumio[918]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:25 music-player-teun volumio[918]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:25 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 04:01:25 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 04:01:25 music-player-teun volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 04:01:25 music-player-teun dhcpcd[18399]: eth0: soliciting an IPv6 router Oct 12 04:01:25 music-player-teun ifplugd(eth0)[832]: client: eth0: soliciting an IPv6 router Oct 12 04:01:25 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:25.288+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 04:01:28 music-player-teun volumio[918]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 04:01:28 music-player-teun volumio[918]: Error: send ENETUNREACH 255.255.255.255:3483 Oct 12 04:01:28 music-player-teun volumio[918]: at doSend (dgram.js:692:16) Oct 12 04:01:28 music-player-teun volumio[918]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Oct 12 04:01:28 music-player-teun volumio[918]: at afterDns (dgram.js:638:5) Oct 12 04:01:28 music-player-teun volumio[918]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Oct 12 04:01:28 music-player-teun volumio[918]: errno: -101, Oct 12 04:01:28 music-player-teun volumio[918]: code: 'ENETUNREACH', Oct 12 04:01:28 music-player-teun volumio[918]: syscall: 'send', Oct 12 04:01:28 music-player-teun volumio[918]: address: '255.255.255.255', Oct 12 04:01:28 music-player-teun volumio[918]: port: 3483 Oct 12 04:01:28 music-player-teun volumio[918]: } Oct 12 04:01:28 music-player-teun volumio[918]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 04:01:29 music-player-teun sudo[18426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-12 04:00 Oct 12 04:01:29 music-player-teun sudo[18426]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:29 music-player-teun sudo[18426]: pam_unix(sudo:session): session closed for user root Oct 12 04:01:29 music-player-teun dhcpcd[18399]: eth0: probing for an IPv4LL address Oct 12 04:01:29 music-player-teun ifplugd(eth0)[832]: client: eth0: probing for an IPv4LL address Oct 12 04:01:29 music-player-teun dhcpcd[18399]: eth0: DHCP lease expired Oct 12 04:01:29 music-player-teun ifplugd(eth0)[832]: client: eth0: DHCP lease expired Oct 12 04:01:29 music-player-teun dhcpcd[18399]: eth0: soliciting a DHCP lease Oct 12 04:01:29 music-player-teun ifplugd(eth0)[832]: client: eth0: soliciting a DHCP lease Oct 12 04:01:29 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:29.998+02:00 level=ERROR msg="failed reading message" error="read tcp 127.0.0.1:52582->127.0.0.1:3000: read: connection reset by peer" Oct 12 04:01:30 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:30.001+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 12 04:01:30 music-player-teun systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 12 04:01:30 music-player-teun volumio-remote-updater[605]: [2026-10-12 04:01:29] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 12 04:01:30 music-player-teun volumio-remote-updater[605]: [2026-10-12 04:01:30] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 12 04:01:30 music-player-teun go-librespot[1320]: time="2026-10-12T04:01:30+02:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Oct 12 04:01:30 music-player-teun systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 12 04:01:30 music-player-teun systemd[1]: Started dynamicswap service. Oct 12 04:01:30 music-player-teun systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 12 04:01:30 music-player-teun systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Oct 12 04:01:30 music-player-teun systemd[1]: Stopped Volumio Backend Module. Oct 12 04:01:30 music-player-teun systemd[1]: Started Volumio Backend Module. Oct 12 04:01:30 music-player-teun systemd[1]: dynamicswap.service: Succeeded. Oct 12 04:01:31 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:31.004+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 12 04:01:32 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:32.007+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 12 04:01:32 music-player-teun dhcpcd[18399]: eth0: carrier lost Oct 12 04:01:32 music-player-teun ifplugd(eth0)[832]: client: eth0: carrier lost Oct 12 04:01:32 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Oct 12 04:01:33 music-player-teun volumio[18449]: info: ------------------------------------------- Oct 12 04:01:33 music-player-teun volumio[18449]: info: ----- Volumio3 ---- Oct 12 04:01:33 music-player-teun volumio[18449]: info: ------------------------------------------- Oct 12 04:01:33 music-player-teun volumio[18449]: info: ----- System startup ---- Oct 12 04:01:33 music-player-teun volumio[18449]: info: ------------------------------------------- Oct 12 04:01:34 music-player-teun dhcpcd[18399]: eth0: carrier acquired Oct 12 04:01:34 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off Oct 12 04:01:34 music-player-teun ifplugd(eth0)[832]: client: eth0: carrier acquired Oct 12 04:01:34 music-player-teun ifplugd(eth0)[832]: client: eth0: IAID eb:c1:22:22 Oct 12 04:01:34 music-player-teun dhcpcd[18399]: eth0: IAID eb:c1:22:22 Oct 12 04:01:34 music-player-teun volumio[18449]: info: MYVOLUMIO Environment detected Oct 12 04:01:34 music-player-teun volumio[18449]: info: Plugin folders cleanup Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning into folder /volumio/app/plugins/ Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning category audio_interface Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning category miscellanea Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning category music_service Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning category plugins.json Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning category system_controller Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning category user_interface Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning into folder /data/plugins/ Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning category music_service Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning category system_controller Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning category system_hardware Oct 12 04:01:34 music-player-teun volumio[18449]: info: Scanning category user_interface Oct 12 04:01:34 music-player-teun volumio[18449]: info: Plugin folders cleanup completed Oct 12 04:01:34 music-player-teun volumio[18449]: info: ------------------------------------------- Oct 12 04:01:34 music-player-teun volumio[18449]: info: ----- Core plugins startup ---- Oct 12 04:01:34 music-player-teun volumio[18449]: info: ------------------------------------------- Oct 12 04:01:34 music-player-teun volumio[18449]: info: Loading plugins from folder /volumio/app/plugins/ Oct 12 04:01:34 music-player-teun volumio[18449]: info: Adding plugin upnp to MyMusic Plugins Oct 12 04:01:34 music-player-teun volumio[18449]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 12 04:01:34 music-player-teun volumio[18449]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 12 04:01:34 music-player-teun volumio[18449]: info: Loading plugins from folder /data/plugins/ Oct 12 04:01:34 music-player-teun volumio[18449]: info: Loading plugin "system"... Oct 12 04:01:34 music-player-teun volumio[18449]: info: Loading plugin "appearance"... Oct 12 04:01:35 music-player-teun volumio-remote-updater[605]: [2026-10-12 04:01:35] [connect] Successful connection Oct 12 04:01:35 music-player-teun ifplugd(eth0)[832]: client: eth0: soliciting an IPv6 router Oct 12 04:01:35 music-player-teun dhcpcd[18399]: eth0: soliciting an IPv6 router Oct 12 04:01:35 music-player-teun ifplugd(eth0)[832]: client: eth0: soliciting a DHCP lease Oct 12 04:01:35 music-player-teun dhcpcd[18399]: eth0: soliciting a DHCP lease Oct 12 04:01:36 music-player-teun volumio[18449]: info: Loading plugin "network"... Oct 12 04:01:36 music-player-teun volumio[18449]: info: Refreshing Cached IP Addresses Oct 12 04:01:36 music-player-teun sudo[18497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 04:01:36 music-player-teun sudo[18497]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:36 music-player-teun volumio[18449]: info: Loading plugin "services"... Oct 12 04:01:36 music-player-teun sudo[18499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 04:01:36 music-player-teun sudo[18499]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:36 music-player-teun sudo[18497]: pam_unix(sudo:session): session closed for user root Oct 12 04:01:36 music-player-teun sudo[18499]: pam_unix(sudo:session): session closed for user root Oct 12 04:01:36 music-player-teun volumio[18449]: info: Loading plugin "volumio5onboarding"... Oct 12 04:01:36 music-player-teun volumio[18449]: info: Loading plugin "alsa_controller"... Oct 12 04:01:36 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 04:01:36 music-player-teun volumio[18449]: info: Loading plugin "wizard"... Oct 12 04:01:36 music-player-teun volumio[18449]: info: Loading plugin "networkfs"... Oct 12 04:01:36 music-player-teun volumio[18449]: info: Starting Udev Watcher for removable devices Oct 12 04:01:36 music-player-teun volumio[18449]: info: Ignoring mount for partition: boot Oct 12 04:01:36 music-player-teun volumio[18449]: info: Ignoring mount for partition: volumio Oct 12 04:01:36 music-player-teun volumio[18449]: info: Ignoring mount for partition: volumio_data Oct 12 04:01:36 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 04:01:36 music-player-teun volumio[18449]: info: Loading plugin "volumio_command_line_client"... Oct 12 04:01:36 music-player-teun volumio[18449]: info: Loading plugin "upnp"... Oct 12 04:01:36 music-player-teun volumio[18449]: info: [1791770496747] Starting Upmpd Daemon Oct 12 04:01:36 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 04:01:36 music-player-teun volumio[18449]: info: Loading plugin "my_music"... Oct 12 04:01:36 music-player-teun volumio[18449]: info: Loading plugin "mpd"... Oct 12 04:01:37 music-player-teun volumio[18449]: info: Loading plugin "upnp_browser"... Oct 12 04:01:37 music-player-teun volumio[18449]: info: Starting UPNP Browser Oct 12 04:01:37 music-player-teun volumio[18449]: info: Loading plugin "alarm-clock"... Oct 12 04:01:38 music-player-teun volumio[18449]: info: Loading plugin "airplay_emulation"... Oct 12 04:01:38 music-player-teun volumio[18449]: info: Starting Shairport Sync Oct 12 04:01:38 music-player-teun volumio[18449]: info: Loading plugin "last_100"... Oct 12 04:01:38 music-player-teun volumio[18449]: info: Loading plugin "webradio"... Oct 12 04:01:38 music-player-teun volumio[18449]: info: Loading plugin "i2s_dacs"... Oct 12 04:01:38 music-player-teun volumio[18449]: info: Loading plugin "volumiodiscovery"... Oct 12 04:01:38 music-player-teun volumio[18449]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 12 04:01:38 music-player-teun volumio[18449]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 04:01:38 music-player-teun volumio[18449]: *** WARNING *** For more information see Oct 12 04:01:38 music-player-teun volumio[18449]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 12 04:01:38 music-player-teun node[18449]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 12 04:01:38 music-player-teun volumio[18449]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 04:01:38 music-player-teun volumio[18449]: *** WARNING *** For more information see Oct 12 04:01:38 music-player-teun node[18449]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 04:01:38 music-player-teun node[18449]: *** WARNING *** For more information see Oct 12 04:01:38 music-player-teun node[18449]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 12 04:01:38 music-player-teun node[18449]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 04:01:38 music-player-teun node[18449]: *** WARNING *** For more information see Oct 12 04:01:38 music-player-teun volumio[18449]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 12 04:01:38 music-player-teun volumio[18449]: info: Discovery: Started advertising with name: Music Player Teun Oct 12 04:01:38 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 04:01:38 music-player-teun volumio[18449]: info: Loading plugin "spop"... Oct 12 04:01:40 music-player-teun dhcpcd[18399]: eth0: probing for an IPv4LL address Oct 12 04:01:40 music-player-teun ifplugd(eth0)[832]: client: eth0: probing for an IPv4LL address Oct 12 04:01:40 music-player-teun dhcpcd[18399]: eth0: carrier lost Oct 12 04:01:40 music-player-teun ifplugd(eth0)[832]: client: eth0: carrier lost Oct 12 04:01:40 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Oct 12 04:01:40 music-player-teun volumio[18449]: info: Loading plugin "squeezelite_mc"... Oct 12 04:01:41 music-player-teun dhcpcd[18399]: eth0: carrier acquired Oct 12 04:01:41 music-player-teun ifplugd(eth0)[832]: client: eth0: carrier acquired Oct 12 04:01:41 music-player-teun kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off Oct 12 04:01:41 music-player-teun dhcpcd[18399]: eth0: IAID eb:c1:22:22 Oct 12 04:01:41 music-player-teun ifplugd(eth0)[832]: client: eth0: IAID eb:c1:22:22 Oct 12 04:01:42 music-player-teun dhcpcd[18399]: eth0: soliciting a DHCP lease Oct 12 04:01:42 music-player-teun ifplugd(eth0)[832]: client: eth0: soliciting a DHCP lease Oct 12 04:01:42 music-player-teun volumio[18449]: info: Loading plugin "now_playing"... Oct 12 04:01:42 music-player-teun dhcpcd[18399]: eth0: soliciting an IPv6 router Oct 12 04:01:42 music-player-teun ifplugd(eth0)[832]: client: eth0: soliciting an IPv6 router Oct 12 04:01:43 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:43.009+02:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:50344->127.0.0.1:3000: i/o timeout" Oct 12 04:01:43 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:43.330+02:00 level=ERROR msg="failed to update discovery on Ethernet info change" error="failed to get system info: could not get system info: context deadline exceeded" Oct 12 04:01:44 music-player-teun volumio[18449]: info: Loading plugin "outputs"... Oct 12 04:01:44 music-player-teun volumio[18449]: info: Loading plugin "albumart"... Oct 12 04:01:44 music-player-teun volumio[18449]: info: Plugin example_plugin is not enabled Oct 12 04:01:44 music-player-teun volumio[18449]: info: Loading plugin "inputs"... Oct 12 04:01:44 music-player-teun volumio[18449]: info: Loading plugin "updater_comm"... Oct 12 04:01:44 music-player-teun volumio[18449]: info: Plugin mpdemulation is not enabled Oct 12 04:01:44 music-player-teun volumio[18449]: info: Loading plugin "rest_api"... Oct 12 04:01:44 music-player-teun volumio[18449]: info: Loading plugin "websocket"... Oct 12 04:01:44 music-player-teun volumio[18449]: info: Starting Socket.io Server version 2.3.0 Oct 12 04:01:44 music-player-teun volumio[18449]: info: Loading plugin "scheduledrestart"... Oct 12 04:01:44 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:44.962+02:00 level=ERROR msg="failed to update discovery on Ethernet info change" error="failed to get system info: could not get system info: context deadline exceeded" Oct 12 04:01:45 music-player-teun volumio[18449]: Forking 3 albumart workers Oct 12 04:01:45 music-player-teun volumio[18449]: info: Applying required configuration parameters for plugin scheduledrestart Oct 12 04:01:45 music-player-teun volumio[18449]: info: Loading plugin "ir_controller"... Oct 12 04:01:45 music-player-teun volumio[18449]: info: Applying required configuration parameters for plugin ir_controller Oct 12 04:01:45 music-player-teun volumio[18449]: info: Loading plugin "touch_display"... Oct 12 04:01:46 music-player-teun volumio[18449]: Starting albumart workers Oct 12 04:01:46 music-player-teun volumio[18449]: Starting albumart workers Oct 12 04:01:46 music-player-teun volumio[18449]: Starting albumart workers Oct 12 04:01:46 music-player-teun volumio[18449]: info: Applying required configuration parameters for plugin touch_display Oct 12 04:01:46 music-player-teun dhcpcd[18399]: eth0: offered 192.168.2.16 from 192.168.2.254 Oct 12 04:01:46 music-player-teun ifplugd(eth0)[832]: client: eth0: offered 192.168.2.16 from 192.168.2.254 Oct 12 04:01:46 music-player-teun dhcpcd[18399]: eth0: probing address 192.168.2.16/24 Oct 12 04:01:46 music-player-teun ifplugd(eth0)[832]: client: eth0: probing address 192.168.2.16/24 Oct 12 04:01:46 music-player-teun volumio[18449]: info: Loading i18n strings for locale nl Oct 12 04:01:47 music-player-teun volumio[18449]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Oct 12 04:01:47 music-player-teun volumio[18449]: Updating browse sources language Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 04:01:47 music-player-teun volumio-remote-updater[605]: [2026-10-12 04:01:47] [connect] Successful connection Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::initPlayerControls Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 04:01:47 music-player-teun volumio[18449]: Express server listening on port 3000 Oct 12 04:01:47 music-player-teun volumio[18449]: [Metrics] WebUI: 15s 415.48ms Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreStateMachine::resetVolumioState Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreStateMachine::getcurrentVolume Oct 12 04:01:47 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 04:01:47 music-player-teun sudo[18618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 04:01:47 music-player-teun sudo[18618]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:47 music-player-teun sudo[18618]: pam_unix(sudo:session): session closed for user root Oct 12 04:01:47 music-player-teun sudo[18620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 04:01:47 music-player-teun sudo[18620]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:47 music-player-teun volumio[18449]: info: Volumio Network Manager: Network status updated: 0 Oct 12 04:01:47 music-player-teun sudo[18620]: pam_unix(sudo:session): session closed for user root Oct 12 04:01:47 music-player-teun volumio[18449]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 12 04:01:48 music-player-teun volumio[18449]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Oct 12 04:01:48 music-player-teun volumio-remote-updater[605]: [2026-10-12 04:01:48] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1791770507 101 Oct 12 04:01:48 music-player-teun volumio[18449]: 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: 2 Oct 12 04:01:48 music-player-teun volumio[18449]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Oct 12 04:01:48 music-player-teun volumio[18449]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined Oct 12 04:01:48 music-player-teun volumio[18449]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 12 04:01:48 music-player-teun volumio[18449]: info: VolumeController:: Volume=100 Mute =false Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreStateMachine::pushState Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioPushState Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreStateMachine::updateTrackBlock Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getTrackBlock Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:01:48 music-player-teun volumio[18449]: info: Reloading queue from file Oct 12 04:01:48 music-player-teun volumio[18449]: info: Listing playlists Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioGetQueue Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreStateMachine::getQueue Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getQueue Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioGetVisibleSources Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:48 music-player-teun volumio[18449]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Oct 12 04:01:48 music-player-teun volumio[18449]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined Oct 12 04:01:48 music-player-teun volumio[18449]: info: Listing playlists Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioGetQueue Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreStateMachine::getQueue Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getQueue Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioGetVisibleSources Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:48 music-player-teun volumio[18449]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreStateMachine::setRepeat null single undefined Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreStateMachine::pushState Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioPushState Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreStateMachine::setRandom false Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreStateMachine::pushState Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioPushState Oct 12 04:01:48 music-player-teun volumio[18449]: info: Setting Device type: Raspberry PI Oct 12 04:01:48 music-player-teun volumio[18449]: info: Completed loading Core Plugins Oct 12 04:01:48 music-player-teun volumio[18449]: info: Preparing to generate the ALSA configuration file Oct 12 04:01:48 music-player-teun volumio[18449]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 12 04:01:48 music-player-teun volumio[18449]: info: VolumeController:: Volume=100 Mute =false Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreStateMachine::pushState Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioPushState Oct 12 04:01:48 music-player-teun sudo[18631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 12 04:01:48 music-player-teun sudo[18631]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:48 music-player-teun volumio[18449]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 12 04:01:48 music-player-teun volumio[18449]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 12 04:01:48 music-player-teun volumio[18449]: info: Received Get System Info Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 04:01:48 music-player-teun volumio[18449]: info: Discovery: Getting this device information Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 04:01:48 music-player-teun volumio[18449]: info: Received Get System Info Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 04:01:48 music-player-teun volumio[18449]: info: Discovery: Getting this device information Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioGetState Oct 12 04:01:48 music-player-teun volumio[18449]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 04:01:48 music-player-teun sudo[18631]: pam_unix(sudo:session): session closed for user root Oct 12 04:01:48 music-player-teun volumio[18449]: info: Asound.conf file unchanged, so no further update is needed Oct 12 04:01:48 music-player-teun volumio[18449]: info: Output device has changed, restarting MPD Oct 12 04:01:48 music-player-teun volumio[18449]: info: Output device has changed, restarting Shairport Sync Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:01:48 music-player-teun sudo[18635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 12 04:01:48 music-player-teun sudo[18635]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:48 music-player-teun sudo[18637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 12 04:01:48 music-player-teun sudo[18637]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:48 music-player-teun systemd[1]: Stopping Music Player Daemon... Oct 12 04:01:48 music-player-teun sudo[18635]: pam_unix(sudo:session): session closed for user root Oct 12 04:01:48 music-player-teun volumio[18449]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 04:01:48 music-player-teun volumio[18449]: info: ___________ START PLUGINS ___________ Oct 12 04:01:48 music-player-teun volumio[18449]: info: ControllerMpd::onStart: Initializing MPD Oct 12 04:01:48 music-player-teun volumio[18449]: info: Creating MPD Configuration file Oct 12 04:01:48 music-player-teun sudo[18645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 12 04:01:48 music-player-teun sudo[18645]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 04:01:48 music-player-teun sudo[18647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 12 04:01:48 music-player-teun volumio[18449]: info: [1791770508875] CoreMusicLibrary::Adding element Media Servers Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 04:01:48 music-player-teun sudo[18647]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:48 music-player-teun sudo[18650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 12 04:01:48 music-player-teun sudo[18647]: pam_unix(sudo:session): session closed for user root Oct 12 04:01:48 music-player-teun sudo[18650]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:48 music-player-teun volumio[18449]: info: UPNP Browser: Client initialized successfully Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:48 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:01:49 music-player-teun sudo[18645]: pam_unix(sudo:session): session closed for user root Oct 12 04:01:49 music-player-teun volumio[18449]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:01:49 music-player-teun volumio[18449]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 04:01:49 music-player-teun volumio[18449]: info: [1791770509121] CoreMusicLibrary::Adding element Last_100 Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 04:01:49 music-player-teun volumio[18449]: info: [1791770509131] CoreMusicLibrary::Adding element Webradio Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 04:01:49 music-player-teun volumio[18449]: info: Initializing BBC Radios Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 04:01:49 music-player-teun volumio[18449]: info: Creating Spotify config file Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:49 music-player-teun volumio[18449]: info: [squeezelite_mc] Starting proxy server... Oct 12 04:01:49 music-player-teun volumio[18449]: info: [now-playing] ConfigUpdater: config is up to date. Oct 12 04:01:49 music-player-teun volumio[18449]: info: Scheduling reboots with hours: 2, minutes: 0 in timezone: Europe/Amsterdam Oct 12 04:01:49 music-player-teun volumio[18449]: info: Scheduling job with cron expression: 0 0 2 * * 1 Oct 12 04:01:49 music-player-teun volumio[18449]: info: Scheduling job with cron expression: 0 0 2 * * 3 Oct 12 04:01:49 music-player-teun volumio[18449]: info: Scheduling job with cron expression: 0 0 2 * * 5 Oct 12 04:01:49 music-player-teun volumio[18449]: info: Loading i18n strings for locale nl Oct 12 04:01:49 music-player-teun volumio[18449]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 04:01:49 music-player-teun volumio[18449]: info: Loading i18n strings for locale nl Oct 12 04:01:49 music-player-teun volumio[18449]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Oct 12 04:01:49 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 04:01:49 music-player-teun volumio[18449]: info: Volumio Calling Home Oct 12 04:01:49 music-player-teun volumio[18449]: info: [squeezelite_mc] Proxy server started on port 40423 Oct 12 04:01:50 music-player-teun sudo[18677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Oct 12 04:01:50 music-player-teun sudo[18677]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:50 music-player-teun sudo[18679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Oct 12 04:01:50 music-player-teun sudo[18679]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:50 music-player-teun sudo[18675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc Oct 12 04:01:50 music-player-teun sudo[18675]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:50 music-player-teun sudo[18675]: pam_unix(sudo:session): session closed for user root Oct 12 04:01:50 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 04:01:50 music-player-teun volumio[18449]: info: [now-playing] App is listening on port 4004. Oct 12 04:01:50 music-player-teun sudo[18683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 12 04:01:50 music-player-teun sudo[18683]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:50 music-player-teun volumio[18449]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Oct 12 04:01:50 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 04:01:50 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 04:01:50 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 04:01:50 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 04:01:50 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:50.609+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 04:01:50 music-player-teun systemd[1]: Reloading. Oct 12 04:01:50 music-player-teun volumio[18449]: info: Upmpdcli Daemon Started Oct 12 04:01:50 music-player-teun volumio[18449]: Unhandled rejection Error: No sockets available, cannot start. Oct 12 04:01:50 music-player-teun volumio[18449]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Oct 12 04:01:50 music-player-teun volumio[18449]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Oct 12 04:01:50 music-player-teun volumio[18449]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Oct 12 04:01:50 music-player-teun volumio[18449]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Oct 12 04:01:50 music-player-teun volumio[18449]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Oct 12 04:01:50 music-player-teun volumio[18449]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Oct 12 04:01:50 music-player-teun volumio[18449]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Oct 12 04:01:50 music-player-teun volumio[18449]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Oct 12 04:01:50 music-player-teun volumio[18449]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Oct 12 04:01:50 music-player-teun volumio[18449]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Oct 12 04:01:50 music-player-teun volumio[18449]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Oct 12 04:01:50 music-player-teun volumio[18449]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Oct 12 04:01:50 music-player-teun volumio[18449]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Oct 12 04:01:50 music-player-teun volumio[18449]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Oct 12 04:01:50 music-player-teun volumio[18449]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Oct 12 04:01:50 music-player-teun volumio[18449]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 12 04:01:50 music-player-teun volumio[18449]: info: An error occurred while refreshing Spotify Token Error: getaddrinfo EBUSY oauth-performer.prod.vlmapi.io Oct 12 04:01:50 music-player-teun volumio[18449]: info: touch_display: No backlight interface detected. Oct 12 04:01:50 music-player-teun volumio[18449]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Oct 12 04:01:50 music-player-teun volumio[18449]: info: MPD Permissions set Oct 12 04:01:50 music-player-teun volumio[18449]: info: MPD Permissions set Oct 12 04:01:50 music-player-teun volumio[18449]: info: VolumeController:: Volume=100 Mute =false Oct 12 04:01:50 music-player-teun volumio[18449]: info: CoreStateMachine::pushState Oct 12 04:01:50 music-player-teun volumio[18449]: info: CorePlayQueue::getTrack 0 Oct 12 04:01:50 music-player-teun volumio[18449]: info: CoreCommandRouter::volumioPushState Oct 12 04:01:50 music-player-teun volumio[18449]: info: [squeezelite_mc] Server discovery started Oct 12 04:01:50 music-player-teun volumio[18449]: info: [squeezelite_mc] Player finder started Oct 12 04:01:50 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 04:01:50 music-player-teun volumio[18449]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 04:01:50 music-player-teun volumio[18449]: info: [squeezelite_mc] Executing aplay -D hw:3 --nonblock -f MPEG /dev/zero 2>&1 || true Oct 12 04:01:50 music-player-teun volumio[18449]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 04:01:50 music-player-teun volumio[18449]: Error: send ENETUNREACH 255.255.255.255:3483 Oct 12 04:01:50 music-player-teun volumio[18449]: at doSend (dgram.js:692:16) Oct 12 04:01:50 music-player-teun volumio[18449]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Oct 12 04:01:50 music-player-teun volumio[18449]: at afterDns (dgram.js:638:5) Oct 12 04:01:50 music-player-teun volumio[18449]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Oct 12 04:01:50 music-player-teun volumio[18449]: errno: -101, Oct 12 04:01:50 music-player-teun volumio[18449]: code: 'ENETUNREACH', Oct 12 04:01:50 music-player-teun volumio[18449]: syscall: 'send', Oct 12 04:01:50 music-player-teun volumio[18449]: address: '255.255.255.255', Oct 12 04:01:50 music-player-teun volumio[18449]: port: 3483 Oct 12 04:01:50 music-player-teun volumio[18449]: } Oct 12 04:01:50 music-player-teun volumio[18449]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 04:01:51 music-player-teun 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. Oct 12 04:01:51 music-player-teun volumio5-onboarding[1684]: time=2026-10-12T04:01:51.609+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 04:01:51 music-player-teun systemd[1]: squeezelite.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 12 04:01:51 music-player-teun sudo[18715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-12 04:00 Oct 12 04:01:51 music-player-teun sudo[18715]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 04:01:51 music-player-teun dhcpcd[18399]: eth0: leased 192.168.2.16 for 864000 seconds Oct 12 04:01:51 music-player-teun ifplugd(eth0)[832]: client: eth0: leased 192.168.2.16 for 864000 seconds Oct 12 04:01:51 music-player-teun avahi-daemon[620]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.2.16. Oct 12 04:01:51 music-player-teun avahi-daemon[620]: New relevant interface eth0.IPv4 for mDNS. Oct 12 04:01:51 music-player-teun dhcpcd[18399]: eth0: adding route to 192.168.2.0/24 Oct 12 04:01:51 music-player-teun dhcpcd[18399]: eth0: adding default route via 192.168.2.254 Oct 12 04:01:51 music-player-teun avahi-daemon[620]: Registering new address record for 192.168.2.16 on eth0.IPv4. Oct 12 04:01:51 music-player-teun ifplugd(eth0)[832]: client: eth0: adding route to 192.168.2.0/24 Oct 12 04:01:51 music-player-teun ifplugd(eth0)[832]: client: eth0: adding default route via 192.168.2.254 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"