Feb 23 12:57:20 musicbox2 ntpd[838]: CLOCK: time stepped by 63768.627676
Feb 23 12:57:20 musicbox2 ntpd[838]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes
Feb 23 12:57:20 musicbox2 systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service...
Feb 23 12:57:20 musicbox2 systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats.
Feb 23 12:57:20 musicbox2 systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully.
Feb 23 12:57:21 musicbox2 systemd[1]: dpkg-db-backup.service: Deactivated successfully.
Feb 23 12:57:21 musicbox2 systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service.
Feb 23 12:57:21 musicbox2 winbindd[1512]: [2026/02/23 12:57:21.530806, 0] ../../source3/winbindd/winbindd_idmap.c:372(wb_parent_idmap_setup_lookupname_done)
Feb 23 12:57:21 musicbox2 winbindd[1512]: wb_parent_idmap_setup_lookupname_done: Lookup domain name 'MUSICBOX2' failed 'NT_STATUS_IO_TIMEOUT'
Feb 23 12:57:21 musicbox2 systemd[1]: Started smbd.service - Samba SMB Daemon.
Feb 23 12:57:21 musicbox2 systemd[1]: Reached target multi-user.target - Multi-User System.
Feb 23 12:57:21 musicbox2 systemd[1]: Reached target graphical.target - Graphical Interface.
Feb 23 12:57:21 musicbox2 systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP...
Feb 23 12:57:21 musicbox2 volumio[1356]: Starting albumart workers
Feb 23 12:57:21 musicbox2 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully.
Feb 23 12:57:21 musicbox2 systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP.
Feb 23 12:57:22 musicbox2 upmpdcli[1411]: :2:../src/mpdcli.cxx:113::MPDCli::openconn: mpd_connection_new failed: Timeout
Feb 23 12:57:22 musicbox2 upmpdcli[1411]: :2:../src/main.cxx:728::MPD connection failed
Feb 23 12:57:23 musicbox2 ifplugd(eth0)[869]: Link beat lost.
Feb 23 12:57:23 musicbox2 dhcpcd[768]: eth0: carrier lost
Feb 23 12:57:23 musicbox2 kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Down
Feb 23 12:57:23 musicbox2 avahi-daemon[661]: Withdrawing address record for 192.168.178.46 on eth0.
Feb 23 12:57:23 musicbox2 avahi-daemon[661]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.178.46.
Feb 23 12:57:23 musicbox2 avahi-daemon[661]: Interface eth0.IPv4 no longer relevant for mDNS.
Feb 23 12:57:23 musicbox2 dhcpcd[768]: eth0: deleting route to 192.168.178.0/24
Feb 23 12:57:23 musicbox2 dhcpcd[768]: eth0: deleting default route via 192.168.178.1
Feb 23 12:57:23 musicbox2 volumio5-onboarding[1454]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:42872->127.0.0.1:3000: i/o timeout
Feb 23 12:57:23 musicbox2 systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE
Feb 23 12:57:23 musicbox2 systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'.
Feb 23 12:57:23 musicbox2 systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Feb 23 12:57:23 musicbox2 systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Feb 23 12:57:23 musicbox2 systemd[1]: welcome.service: Deactivated successfully.
Feb 23 12:57:23 musicbox2 systemd[1]: Stopped welcome.service - Show a welcome message on console.
Feb 23 12:57:23 musicbox2 systemd[1]: Stopping welcome.service - Show a welcome message on console...
Feb 23 12:57:23 musicbox2 systemd[1]: Starting welcome.service - Show a welcome message on console...
Feb 23 12:57:23 musicbox2 systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1.
Feb 23 12:57:23 musicbox2 welcome[1610]: Resolved ip:[0]
Feb 23 12:57:23 musicbox2 systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server.
Feb 23 12:57:23 musicbox2 systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server.
Feb 23 12:57:23 musicbox2 systemd[1]: Finished welcome.service - Show a welcome message on console.
Feb 23 12:57:23 musicbox2 systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Feb 23 12:57:23 musicbox2 volumio5-onboarding[1613]: time=2026-02-23T12:57:23.705+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z
Feb 23 12:57:24 musicbox2 ntpd[838]: IO: Deleting interface #3 eth0, 192.168.178.46#123, interface stats: received=48, sent=48, dropped=0, active_time=10 secs
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 86.80.166.233 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 94.198.159.15 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 86.85.103.243 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 178.239.19.58 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 162.159.200.1 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 81.172.248.188 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 62.238.235.89 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 194.104.0.153 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 160.44.205.138 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 139.162.156.95 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 185.232.69.65 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 172.104.134.72 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 172.233.38.176 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 103.204.195.5 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 79.132.137.48 unlink local addr 192.168.178.46 ->
Feb 23 12:57:24 musicbox2 ntpd[838]: PROTO: 45.9.2.181 unlink local addr 192.168.178.46 ->
Feb 23 12:57:26 musicbox2 volumio[1146]: info: [squeezelite_mc] Starting proxy server...
Feb 23 12:57:26 musicbox2 volumio[1146]: info: AutoStart - onStart
Feb 23 12:57:26 musicbox2 volumio[1146]: info: Loading i18n strings for locale de
Feb 23 12:57:26 musicbox2 volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 23 12:57:26 musicbox2 volumio[1146]: info: Volumio Calling Home
Feb 23 12:57:27 musicbox2 volumio-remote-updater[678]: [2026-02-23 12:57:27] [connect] Successful connection
Feb 23 12:57:27 musicbox2 mpd[1469]: 2026-02-23T12:57:27 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 23 12:57:27 musicbox2 systemd[1]: Started mpd.service - Music Player Daemon.
Feb 23 12:57:27 musicbox2 systemd[1]: Startup finished in 19.542s (kernel) + 1min 33.226s (userspace) = 1min 52.769s.
Feb 23 12:57:28 musicbox2 sudo[1448]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:28 musicbox2 sudo[1434]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:28 musicbox2 upmpdcli[1628]: writing RSA key
Feb 23 12:57:28 musicbox2 upmpdcli[1411]: :2:../libupnpp/upnpplib.cxx:345::LibUPnP::setupWebServer(): UpnpRegisterRootDevice2 :-204: UPNP_E_SOCKET_CONNECT description http://192.168.178.46:49152/uuid-8e5ed403-9152-83ba-370c-b827eb996c5b/description.xml
Feb 23 12:57:28 musicbox2 upmpdcli[1411]: :2:../libupnpp/device/devdevice.cxx:334::UpnpDevice: libupnp can't start service. Err -204
Feb 23 12:57:28 musicbox2 upmpdcli[1411]: :2:../libupnpp/device/devdevice.cxx:749::Device would not start
Feb 23 12:57:28 musicbox2 upmpdcli[1411]: :2:../libupnpp/upnpplib.cxx:345::LibUPnP::setupWebServer(): UpnpRegisterRootDevice2 :-204: UPNP_E_SOCKET_CONNECT description http://192.168.178.46:49152/uuid-fca4fe2e-a681-010a-ff09-b827eb996c5b/description.xml
Feb 23 12:57:28 musicbox2 upmpdcli[1411]: :2:../libupnpp/device/devdevice.cxx:334::UpnpDevice: libupnp can't start service. Err -204
Feb 23 12:57:28 musicbox2 upmpdcli[1411]: :2:../libupnpp/device/devdevice.cxx:749::Device would not start
Feb 23 12:57:28 musicbox2 volumio[1146]: info: [squeezelite_mc] Proxy server started on port 45469
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.697756, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
Feb 23 12:57:28 musicbox2 nmbd[1031]: Packet send failed to 192.168.178.255(138) ERRNO=Network is unreachable
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.698508, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
Feb 23 12:57:28 musicbox2 nmbd[1031]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.698679, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Feb 23 12:57:28 musicbox2 nmbd[1031]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.698854, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
Feb 23 12:57:28 musicbox2 nmbd[1031]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.698985, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Feb 23 12:57:28 musicbox2 nmbd[1031]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.699127, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
Feb 23 12:57:28 musicbox2 nmbd[1031]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.699261, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Feb 23 12:57:28 musicbox2 nmbd[1031]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.699398, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
Feb 23 12:57:28 musicbox2 nmbd[1031]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.699526, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Feb 23 12:57:28 musicbox2 nmbd[1031]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.699665, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
Feb 23 12:57:28 musicbox2 nmbd[1031]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.699794, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Feb 23 12:57:28 musicbox2 nmbd[1031]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.699981, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
Feb 23 12:57:28 musicbox2 nmbd[1031]: Packet send failed to 192.168.178.255(137) ERRNO=Network is unreachable
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.700112, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Feb 23 12:57:28 musicbox2 nmbd[1031]: send_netbios_packet: send_packet() to IP 192.168.178.255 port 137 failed
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.700234, 0] ../../source3/nmbd/nmbd_namequery.c:245(query_name)
Feb 23 12:57:28 musicbox2 nmbd[1031]: query_name: Failed to send packet trying to query name WORKGROUP<1d>
Feb 23 12:57:28 musicbox2 nmbd[1031]: [2026/02/23 12:57:28.701695, 0] ../../source3/nmbd/nmbd.c:359(reload_interfaces)
Feb 23 12:57:28 musicbox2 nmbd[1031]: reload_interfaces: No subnets to listen to. Waiting..
Feb 23 12:57:30 musicbox2 sudo[1657]: volumio : 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
Feb 23 12:57:30 musicbox2 sudo[1657]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 23 12:57:30 musicbox2 sudo[1657]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:32 musicbox2 volumio[1146]: info: CoreCommandRouter::volumioRetrievevolume
Feb 23 12:57:32 musicbox2 volumio[1146]: Unhandled rejection Error: No sockets available, cannot start.
Feb 23 12:57:32 musicbox2 volumio[1146]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11)
Feb 23 12:57:32 musicbox2 volumio[1146]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10)
Feb 23 12:57:32 musicbox2 volumio[1146]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10
Feb 23 12:57:32 musicbox2 volumio[1146]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9)
Feb 23 12:57:32 musicbox2 volumio[1146]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18)
Feb 23 12:57:32 musicbox2 volumio[1146]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10)
Feb 23 12:57:32 musicbox2 volumio[1146]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10)
Feb 23 12:57:32 musicbox2 volumio[1146]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17)
Feb 23 12:57:32 musicbox2 volumio[1146]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14)
Feb 23 12:57:32 musicbox2 volumio[1146]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24)
Feb 23 12:57:32 musicbox2 volumio[1146]: at HashMap. (/volumio/app/pluginmanager.js:496:31)
Feb 23 12:57:32 musicbox2 volumio[1146]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Feb 23 12:57:32 musicbox2 volumio[1146]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Feb 23 12:57:32 musicbox2 volumio[1146]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20)
Feb 23 12:57:32 musicbox2 volumio[1146]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29)
Feb 23 12:57:32 musicbox2 volumio[1146]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Feb 23 12:57:32 musicbox2 volumio[1146]: info: An error occurred while refreshing Spotify Token Error: getaddrinfo EBUSY oauth-performer.prod.vlmapi.io
Feb 23 12:57:32 musicbox2 volumio[1146]: info: Volumio Network Manager: Network status updated: 1
Feb 23 12:57:32 musicbox2 volumio[1146]: info: ir_controller: File permissions successfully set on /etc/lirc/*.
Feb 23 12:57:32 musicbox2 volumio[1146]: info: MPD Permissions set
Feb 23 12:57:32 musicbox2 volumio[1146]: info: MPD Permissions set
Feb 23 12:57:32 musicbox2 volumio[1146]: info: Upmpdcli Daemon Started
Feb 23 12:57:33 musicbox2 volumio[1146]: info: VolumeController:: Volume=86 Mute =false
Feb 23 12:57:33 musicbox2 ifplugd(eth0)[869]: Executing '/etc/ifplugd/ifplugd.action eth0 down'.
Feb 23 12:57:33 musicbox2 volumio[1146]: info: CoreStateMachine::pushState
Feb 23 12:57:33 musicbox2 volumio[1146]: info: CorePlayQueue::getTrack 0
Feb 23 12:57:33 musicbox2 volumio[1146]: info: CoreCommandRouter::volumioPushState
Feb 23 12:57:33 musicbox2 volumio[1146]: info: [squeezelite_mc] Server discovery started
Feb 23 12:57:33 musicbox2 dhcpcd[1687]: dhcpcd not running
Feb 23 12:57:33 musicbox2 ifplugd(eth0)[869]: client: dhcpcd not running
Feb 23 12:57:33 musicbox2 volumio[1146]: info: [squeezelite_mc] Player finder started
Feb 23 12:57:33 musicbox2 volumio[1146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 12:57:33 musicbox2 volumio[1146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 12:57:33 musicbox2 volumio[1146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 12:57:33 musicbox2 volumio[1146]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 12:57:33 musicbox2 volumio[1146]: info: [squeezelite_mc] Executing aplay -D hw:3 --nonblock -f MPEG /dev/zero 2>&1 || true
Feb 23 12:57:33 musicbox2 ifplugd(eth0)[869]: Program executed successfully.
Feb 23 12:57:33 musicbox2 kernel: 8021q: adding VLAN 0 to HW filter on device eth0
Feb 23 12:57:33 musicbox2 kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Down
Feb 23 12:57:33 musicbox2 volumio[1146]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 23 12:57:33 musicbox2 volumio5-onboarding[1613]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:50820->127.0.0.1:3000: i/o timeout
Feb 23 12:57:33 musicbox2 systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE
Feb 23 12:57:33 musicbox2 systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'.
Feb 23 12:57:33 musicbox2 volumio[1146]: Error: send ENETUNREACH 255.255.255.255:3483
Feb 23 12:57:33 musicbox2 volumio[1146]: at doSend (node:dgram:717:16)
Feb 23 12:57:33 musicbox2 volumio[1146]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18)
Feb 23 12:57:33 musicbox2 volumio[1146]: at afterDns (node:dgram:663:5)
Feb 23 12:57:33 musicbox2 volumio[1146]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) {
Feb 23 12:57:33 musicbox2 volumio[1146]: errno: -101,
Feb 23 12:57:33 musicbox2 volumio[1146]: code: 'ENETUNREACH',
Feb 23 12:57:33 musicbox2 volumio[1146]: syscall: 'send',
Feb 23 12:57:33 musicbox2 volumio[1146]: address: '255.255.255.255',
Feb 23 12:57:33 musicbox2 volumio[1146]: port: 3483
Feb 23 12:57:33 musicbox2 volumio[1146]: }
Feb 23 12:57:33 musicbox2 volumio[1146]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 23 12:57:33 musicbox2 systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 2.
Feb 23 12:57:33 musicbox2 systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server.
Feb 23 12:57:33 musicbox2 systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server.
Feb 23 12:57:34 musicbox2 volumio5-onboarding[1707]: time=2026-02-23T12:57:34.006+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z
Feb 23 12:57:34 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: === SNM TRANSITION ===
Feb 23 12:57:34 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Previous ethernet state: connected
Feb 23 12:57:34 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: New ethernet state: disconnected
Feb 23 12:57:34 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Single Network Mode: enabled
Feb 23 12:57:34 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: First start: no
Feb 23 12:57:34 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Action: Reconnect WiFi
Feb 23 12:57:34 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: === END TRANSITION ===
Feb 23 12:57:34 musicbox2 sudo[1727]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 23 12:57:34 musicbox2 sudo[1727]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 23 12:57:34 musicbox2 sudo[1727]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:34 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: SNM: Ethernet disconnected, reconnecting WiFi
Feb 23 12:57:34 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: SNM: Ethernet disconnected, reconnecting WiFi
Feb 23 12:57:35 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: reconnectWiFi: WiFi reconnection triggered
Feb 23 12:57:36 musicbox2 ifplugd(eth0)[869]: Link beat detected.
Feb 23 12:57:36 musicbox2 dhcpcd[768]: eth0: carrier acquired
Feb 23 12:57:36 musicbox2 ifplugd(eth0)[869]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Feb 23 12:57:36 musicbox2 kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx
Feb 23 12:57:36 musicbox2 dhcpcd[768]: eth0: IAID eb:99:6c:5b
Feb 23 12:57:36 musicbox2 dhcpcd[768]: eth0: rebinding lease of 192.168.178.46
Feb 23 12:57:36 musicbox2 dhcpcd[768]: eth0: probing address 192.168.178.46/24
Feb 23 12:57:37 musicbox2 dhcpcd[768]: ps_ctl_dispatch: cannot handle another client
Feb 23 12:57:37 musicbox2 ifplugd(eth0)[869]: client: sending commands to dhcpcd process
Feb 23 12:57:37 musicbox2 dhcpcd[768]: control_free: No such file or directory
Feb 23 12:57:37 musicbox2 dhcpcd[768]: eth0: soliciting an IPv6 router
Feb 23 12:57:37 musicbox2 wpa_supplicant[1127]: wlan0: Trying to associate with fc:ec:da:18:92:22 (SSID='Standard12' freq=5200 MHz)
Feb 23 12:57:37 musicbox2 ifplugd(eth0)[869]: Program executed successfully.
Feb 23 12:57:37 musicbox2 wpa_supplicant[1127]: wlan0: Associated with fc:ec:da:18:92:22
Feb 23 12:57:37 musicbox2 wpa_supplicant[1127]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Feb 23 12:57:37 musicbox2 wpa_supplicant[1127]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE
Feb 23 12:57:37 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: === SNM TRANSITION ===
Feb 23 12:57:37 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Previous ethernet state: disconnected
Feb 23 12:57:37 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: New ethernet state: connected
Feb 23 12:57:37 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Single Network Mode: enabled
Feb 23 12:57:37 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: First start: no
Feb 23 12:57:37 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode)
Feb 23 12:57:37 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: === END TRANSITION ===
Feb 23 12:57:37 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: SNM: Ethernet connected, switching to ethernet (WiFi scan mode)
Feb 23 12:57:37 musicbox2 sudo[1790]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd -k wlan0
Feb 23 12:57:37 musicbox2 sudo[1790]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 23 12:57:38 musicbox2 dhcpcd[1791]: dhcpcd not running
Feb 23 12:57:38 musicbox2 sudo[1790]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:38 musicbox2 wireless.js[681]: dhcpcd not running
Feb 23 12:57:38 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow
Feb 23 12:57:38 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: reconnectWiFi: WiFi reconnect incomplete (wpa_state=4WAY_HANDSHAKE), reinitializing wireless flow
Feb 23 12:57:38 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow
Feb 23 12:57:38 musicbox2 wpa_supplicant[1127]: wlan0: WPA: Key negotiation completed with fc:ec:da:18:92:22 [PTK=CCMP GTK=CCMP]
Feb 23 12:57:38 musicbox2 wpa_supplicant[1127]: wlan0: CTRL-EVENT-CONNECTED - Connection to fc:ec:da:18:92:22 completed [id=0 id_str=]
Feb 23 12:57:38 musicbox2 dhcpcd[768]: wlan0: carrier acquired
Feb 23 12:57:38 musicbox2 dhcpcd[768]: wlan0: connected to Access Point: Standard12
Feb 23 12:57:38 musicbox2 wpa_supplicant[1127]: wlan0: RRM: Unexpected neighbor report
Feb 23 12:57:38 musicbox2 dhcpcd[768]: wlan0: IAID eb:cc:39:0e
Feb 23 12:57:38 musicbox2 dhcpcd[768]: wlan0: adding address fe80::7382:e2b3:49ca:1382
Feb 23 12:57:38 musicbox2 dhcpcd[768]: ipv6_addaddr1: Permission denied
Feb 23 12:57:38 musicbox2 wpa_supplicant[1127]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 23 12:57:38 musicbox2 wpa_supplicant[1127]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 23 12:57:38 musicbox2 wpa_supplicant[1127]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0
Feb 23 12:57:38 musicbox2 wpa_supplicant[1127]: p2p-dev-wlan0: CTRL-EVENT-TERMINATING
Feb 23 12:57:38 musicbox2 wpa_supplicant[1127]: wlan0: CTRL-EVENT-DISCONNECTED bssid=fc:ec:da:18:92:22 reason=3 locally_generated=1
Feb 23 12:57:38 musicbox2 dhcpcd[768]: wlan0: carrier lost - roaming
Feb 23 12:57:38 musicbox2 wpa_supplicant[1127]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 23 12:57:38 musicbox2 sudo[1823]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Feb 23 12:57:38 musicbox2 sudo[1823]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 23 12:57:38 musicbox2 sudo[1823]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:38 musicbox2 sudo[1825]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Feb 23 12:57:39 musicbox2 sudo[1825]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 23 12:57:39 musicbox2 sudo[1825]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:39 musicbox2 dhcpcd[768]: wlan0: soliciting an IPv6 router
Feb 23 12:57:39 musicbox2 wpa_supplicant[1127]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 23 12:57:39 musicbox2 wpa_supplicant[1127]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Feb 23 12:57:39 musicbox2 sudo[1831]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Feb 23 12:57:39 musicbox2 sudo[1831]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 23 12:57:39 musicbox2 sudo[1833]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Feb 23 12:57:39 musicbox2 sudo[1833]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 23 12:57:39 musicbox2 dhcpcd[768]: wlan0: carrier lost
Feb 23 12:57:39 musicbox2 wpa_supplicant[1127]: wlan0: CTRL-EVENT-TERMINATING
Feb 23 12:57:39 musicbox2 sudo[1831]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:39 musicbox2 sudo[1833]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:39 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Cleaning previous...
Feb 23 12:57:39 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Cleaning previous...
Feb 23 12:57:39 musicbox2 sudo[1849]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Feb 23 12:57:39 musicbox2 sudo[1849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 23 12:57:39 musicbox2 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Feb 23 12:57:39 musicbox2 sudo[1849]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:39 musicbox2 sudo[1852]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Feb 23 12:57:39 musicbox2 sudo[1852]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 23 12:57:39 musicbox2 sudo[1852]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:39 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations
Feb 23 12:57:39 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 3ms
Feb 23 12:57:39 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: b8:27:eb:cc:39:0e)
Feb 23 12:57:39 musicbox2 sudo[1861]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Feb 23 12:57:39 musicbox2 sudo[1861]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 23 12:57:40 musicbox2 sudo[1861]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:40 musicbox2 sudo[1869]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Feb 23 12:57:40 musicbox2 sudo[1869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 23 12:57:41 musicbox2 dhcpcd[768]: eth0: leased 192.168.178.46 for 864000 seconds
Feb 23 12:57:41 musicbox2 avahi-daemon[661]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.178.46.
Feb 23 12:57:41 musicbox2 avahi-daemon[661]: New relevant interface eth0.IPv4 for mDNS.
Feb 23 12:57:41 musicbox2 avahi-daemon[661]: Registering new address record for 192.168.178.46 on eth0.IPv4.
Feb 23 12:57:41 musicbox2 dhcpcd[768]: eth0: adding route to 192.168.178.0/24
Feb 23 12:57:41 musicbox2 dhcpcd[768]: eth0: adding default route via 192.168.178.1
Feb 23 12:57:41 musicbox2 systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Feb 23 12:57:41 musicbox2 systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Feb 23 12:57:41 musicbox2 systemd[1]: welcome.service: Deactivated successfully.
Feb 23 12:57:41 musicbox2 systemd[1]: Stopped welcome.service - Show a welcome message on console.
Feb 23 12:57:41 musicbox2 systemd[1]: Stopping welcome.service - Show a welcome message on console...
Feb 23 12:57:41 musicbox2 systemd[1]: Starting welcome.service - Show a welcome message on console...
Feb 23 12:57:41 musicbox2 welcome[1895]: Resolved ip:[1] 192.168.178.46
Feb 23 12:57:41 musicbox2 systemd[1]: Finished welcome.service - Show a welcome message on console.
Feb 23 12:57:41 musicbox2 systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Feb 23 12:57:42 musicbox2 sudo[1869]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:42 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Regdomain already correct: DE
Feb 23 12:57:42 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability
Feb 23 12:57:42 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode)
Feb 23 12:57:42 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active
Feb 23 12:57:42 musicbox2 volumio-remote-updater[678]: [2026-02-23 12:57:42] [connect] Successful connection
Feb 23 12:57:42 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations
Feb 23 12:57:42 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 2ms
Feb 23 12:57:42 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: b8:27:eb:cc:39:0e)
Feb 23 12:57:43 musicbox2 sudo[1912]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Feb 23 12:57:43 musicbox2 sudo[1912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 23 12:57:43 musicbox2 sudo[1912]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:43 musicbox2 sudo[1920]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Feb 23 12:57:43 musicbox2 sudo[1920]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 23 12:57:44 musicbox2 volumio5-onboarding[1707]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:40124->127.0.0.1:3000: i/o timeout
Feb 23 12:57:44 musicbox2 systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE
Feb 23 12:57:44 musicbox2 systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'.
Feb 23 12:57:44 musicbox2 systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 3.
Feb 23 12:57:44 musicbox2 systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server.
Feb 23 12:57:44 musicbox2 systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server.
Feb 23 12:57:44 musicbox2 ntpd[838]: IO: Listen normally on 4 eth0 192.168.178.46:123
Feb 23 12:57:44 musicbox2 ntpd[838]: IO: new interface(s) found: waking up resolver
Feb 23 12:57:44 musicbox2 volumio5-onboarding[1924]: time=2026-02-23T12:57:44.518+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z
Feb 23 12:57:45 musicbox2 sudo[1933]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-23 12:56'
Feb 23 12:57:45 musicbox2 sudo[1933]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 23 12:57:45 musicbox2 sudo[1920]: pam_unix(sudo:session): session closed for user root
Feb 23 12:57:45 musicbox2 wireless.js[681]: WIRELESS.JS - INFO: Regdomain already correct: DE
Feb 23 12:57:46 musicbox2 sudo[1938]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Feb 23 12:57:46 musicbox2 sudo[1938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 23 12:57:46 musicbox2 sudo[1938]: pam_unix(sudo:session): session closed for user root
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"