-- Logs begin at Sat 2024-07-20 18:01:04 UTC, end at Sat 2025-11-01 09:44:13 UTC. -- Nov 01 09:43:00 volumio2 systemd[1]: Starting Volumio Backend Module... Nov 01 09:43:00 volumio2 systemd[1]: Started Volumio Backend Module. Nov 01 09:43:00 volumio2 systemd[1]: Starting Volumio Streaming Daemon... Nov 01 09:43:00 volumio2 systemd[1]: Started Volumio Streaming Daemon. Nov 01 09:43:00 volumio2 dnsmasq[854]: started, version 2.72 cachesize 150 Nov 01 09:43:00 volumio2 dnsmasq[854]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect Nov 01 09:43:00 volumio2 dnsmasq[854]: reading /etc/resolv.conf Nov 01 09:43:00 volumio2 dnsmasq[854]: using nameserver 192.168.178.1#53 Nov 01 09:43:00 volumio2 dnsmasq[854]: using nameserver 208.67.222.222#53 Nov 01 09:43:00 volumio2 dnsmasq[854]: using nameserver 208.67.220.220#53 Nov 01 09:43:00 volumio2 dnsmasq[854]: read /etc/hosts - 1 addresses Nov 01 09:43:00 volumio2 systemd[1]: Started dnsmasq.service. Nov 01 09:43:00 volumio2 systemd[1]: Starting Host and Network Name Lookups. Nov 01 09:43:00 volumio2 systemd[1]: Reached target Host and Network Name Lookups. Nov 01 09:43:00 volumio2 winbind[594]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Nov 01 09:43:00 volumio2 winbind[594]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Nov 01 09:43:00 volumio2 winbind[594]: Unable to setup corepath for winbindd: No such file or directory Nov 01 09:43:00 volumio2 winbind[594]: mkdir failed on directory /var/log/samba/cores: No such file or directory Nov 01 09:43:00 volumio2 winbind[594]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Nov 01 09:43:00 volumio2 winbind[594]: Unable to setup corepath for winbindd: No such file or directory Nov 01 09:43:00 volumio2 winbind[594]: [2025/11/01 09:43:00, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:00 volumio2 winbind[594]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 01 09:43:00 volumio2 winbind[594]: [2025/11/01 09:43:00, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:00 volumio2 winbind[594]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 01 09:43:00 volumio2 winbind[594]: [2025/11/01 09:43:00, 0] ../source3/winbindd/winbindd.c:1549(main) Nov 01 09:43:00 volumio2 winbind[594]: winbindd version 4.2.14-Debian started. Nov 01 09:43:00 volumio2 winbind[594]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Nov 01 09:43:00 volumio2 winbind[594]: [2025/11/01 09:43:00, 0] ../lib/util/util.c:220(directory_create_or_exist) Nov 01 09:43:01 volumio2 winbind[594]: mkdir failed on directory /var/log/samba/cores: No such file or directory Nov 01 09:43:01 volumio2 winbind[594]: [2025/11/01 09:43:00, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Nov 01 09:43:01 volumio2 winbind[594]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Nov 01 09:43:01 volumio2 winbind[594]: [2025/11/01 09:43:00, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Nov 01 09:43:01 volumio2 winbind[594]: Unable to setup corepath for winbindd: No such file or directory Nov 01 09:43:00 volumio2 winbindd[800]: [2025/11/01 09:43:00.777912, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:00 volumio2 winbindd[800]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 01 09:43:00 volumio2 winbindd[800]: [2025/11/01 09:43:00.781775, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:00 volumio2 winbindd[800]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 01 09:43:00 volumio2 dhcpd[848]: Internet Systems Consortium DHCP Server 4.3.1 Nov 01 09:43:00 volumio2 dhcpd[848]: Copyright 2004-2014 Internet Systems Consortium. Nov 01 09:43:00 volumio2 dhcpd[848]: All rights reserved. Nov 01 09:43:00 volumio2 dhcpd[848]: For info, please visit https://www.isc.org/software/dhcp/ Nov 01 09:43:00 volumio2 dhcpd[848]: Config file: /etc/dhcp/dhcpd.conf Nov 01 09:43:00 volumio2 dhcpd[848]: Database file: /var/lib/dhcp/dhcpd.leases Nov 01 09:43:00 volumio2 dhcpd[848]: PID file: /var/run/dhcpd.pid Nov 01 09:43:01 volumio2 winbindd[859]: [2025/11/01 09:43:01.047312, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Nov 01 09:43:01 volumio2 winbindd[859]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 01 09:43:01 volumio2 nmbd[823]: [2025/11/01 09:43:01.378450, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:01 volumio2 nmbd[823]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 01 09:43:01 volumio2 systemd[1]: Started LSB: start Winbind daemon. Nov 01 09:43:01 volumio2 nmbd[823]: [2025/11/01 09:43:01.474346, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:01 volumio2 nmbd[823]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 01 09:43:01 volumio2 winbind[594]: [2025/11/01 09:43:00.777912, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:01 volumio2 winbind[594]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 01 09:43:01 volumio2 winbind[594]: [2025/11/01 09:43:00.781775, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:01 volumio2 winbind[594]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Nov 01 09:43:01 volumio2 winbindd[859]: [2025/11/01 09:43:01.503754, 0] ../lib/util/become_daemon.c:124(daemon_ready) Nov 01 09:43:01 volumio2 winbindd[859]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 01 09:43:01 volumio2 nmbd[864]: [2025/11/01 09:43:01.571803, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Nov 01 09:43:01 volumio2 nmbd[864]: started asyncdns process 866 Nov 01 09:43:01 volumio2 winbindd[865]: [2025/11/01 09:43:01.615693, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:01 volumio2 winbindd[865]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO2': No such file or directory Nov 01 09:43:01 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:01 volumio2 systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Nov 01 09:43:01 volumio2 systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Nov 01 09:43:01 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:01 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:01 volumio2 dhcpd[848]: Internet Systems Consortium DHCP Server 4.3.1 Nov 01 09:43:01 volumio2 dhcpd[848]: Copyright 2004-2014 Internet Systems Consortium. Nov 01 09:43:01 volumio2 dhcpd[848]: All rights reserved. Nov 01 09:43:01 volumio2 dhcpd[848]: For info, please visit https://www.isc.org/software/dhcp/ Nov 01 09:43:01 volumio2 nmbd[864]: [2025/11/01 09:43:01.789808, 0] ../lib/util/become_daemon.c:124(daemon_ready) Nov 01 09:43:01 volumio2 nmbd[864]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 01 09:43:01 volumio2 dhcpd[848]: Wrote 0 leases to leases file. Nov 01 09:43:01 volumio2 dhcpd[848]: Nov 01 09:43:01 volumio2 dhcpd[848]: No subnet declaration for eth0 (192.168.178.87). Nov 01 09:43:01 volumio2 dhcpd[848]: ** Ignoring requests on eth0. If this is not what Nov 01 09:43:01 volumio2 dhcpd[848]: you want, please write a subnet declaration Nov 01 09:43:01 volumio2 dhcpd[848]: in your dhcpd.conf file for the network segment Nov 01 09:43:01 volumio2 dhcpd[848]: to which interface eth0 is attached. ** Nov 01 09:43:01 volumio2 dhcpd[848]: Nov 01 09:43:01 volumio2 dhcpd[848]: Nov 01 09:43:01 volumio2 dhcpd[848]: Not configured to listen on any interfaces! Nov 01 09:43:02 volumio2 dhcpd[848]: Nov 01 09:43:02 volumio2 dhcpd[848]: If you think you have received this message due to a bug rather Nov 01 09:43:02 volumio2 dhcpd[848]: than a configuration issue please read the section on submitting Nov 01 09:43:02 volumio2 dhcpd[848]: bugs on either our web page at www.isc.org or in the README file Nov 01 09:43:02 volumio2 dhcpd[848]: before submitting a bug. These pages explain the proper Nov 01 09:43:02 volumio2 dhcpd[848]: process and the information we find helpful for debugging.. Nov 01 09:43:02 volumio2 dhcpd[848]: Nov 01 09:43:02 volumio2 dhcpd[848]: exiting. Nov 01 09:43:01 volumio2 systemd[1]: Started Xbindrc. Nov 01 09:43:02 volumio2 systemd[1]: dhcpd.service: control process exited, code=exited status=1 Nov 01 09:43:02 volumio2 systemd[1]: Failed to start dhcpd.service. Nov 01 09:43:02 volumio2 systemd[1]: Unit dhcpd.service entered failed state. Nov 01 09:43:02 volumio2 hotspot[848]: Internet Systems Consortium DHCP Server 4.3.1 Nov 01 09:43:02 volumio2 hotspot[848]: Copyright 2004-2014 Internet Systems Consortium. Nov 01 09:43:02 volumio2 hotspot[848]: All rights reserved. Nov 01 09:43:02 volumio2 hotspot[848]: For info, please visit https://www.isc.org/software/dhcp/ Nov 01 09:43:02 volumio2 hotspot[848]: Config file: /etc/dhcp/dhcpd.conf Nov 01 09:43:02 volumio2 hotspot[848]: Database file: /var/lib/dhcp/dhcpd.leases Nov 01 09:43:02 volumio2 hotspot[848]: PID file: /var/run/dhcpd.pid Nov 01 09:43:02 volumio2 hotspot[848]: Wrote 0 leases to leases file. Nov 01 09:43:02 volumio2 hotspot[848]: No subnet declaration for eth0 (192.168.178.87). Nov 01 09:43:02 volumio2 hotspot[848]: ** Ignoring requests on eth0. If this is not what Nov 01 09:43:02 volumio2 hotspot[848]: you want, please write a subnet declaration Nov 01 09:43:02 volumio2 hotspot[848]: in your dhcpd.conf file for the network segment Nov 01 09:43:02 volumio2 hotspot[848]: to which interface eth0 is attached. ** Nov 01 09:43:02 volumio2 hotspot[848]: Not configured to listen on any interfaces! Nov 01 09:43:02 volumio2 hotspot[848]: If you think you have received this message due to a bug rather Nov 01 09:43:02 volumio2 hotspot[848]: than a configuration issue please read the section on submitting Nov 01 09:43:02 volumio2 hotspot[848]: bugs on either our web page at www.isc.org or in the README file Nov 01 09:43:02 volumio2 hotspot[848]: before submitting a bug. These pages explain the proper Nov 01 09:43:02 volumio2 hotspot[848]: process and the information we find helpful for debugging.. Nov 01 09:43:02 volumio2 hotspot[848]: exiting. Nov 01 09:43:02 volumio2 nmbd[600]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Nov 01 09:43:02 volumio2 nmbd[600]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Nov 01 09:43:02 volumio2 nmbd[600]: Unable to setup corepath for nmbd: No such file or directory Nov 01 09:43:02 volumio2 nmbd[600]: [2025/11/01 09:43:01, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:02 volumio2 nmbd[600]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 01 09:43:02 volumio2 nmbd[600]: [2025/11/01 09:43:01, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:02 volumio2 nmbd[600]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 01 09:43:02 volumio2 nmbd[600]: [2025/11/01 09:43:01, 0] ../source3/nmbd/nmbd.c:908(main) Nov 01 09:43:02 volumio2 nmbd[600]: nmbd version 4.2.14-Debian started. Nov 01 09:43:02 volumio2 nmbd[600]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Nov 01 09:43:02 volumio2 nmbd[600]: [2025/11/01 09:43:01.378450, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:02 volumio2 nmbd[600]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 01 09:43:02 volumio2 nmbd[600]: [2025/11/01 09:43:01.474346, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:02 volumio2 nmbd[600]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Nov 01 09:43:02 volumio2 winbind[594]: . Nov 01 09:43:02 volumio2 nmbd[600]: . Nov 01 09:43:03 volumio2 volumio-streaming-daemon[852]: ############################ Nov 01 09:43:03 volumio2 volumio-streaming-daemon[852]: # Volumio Streaming Daemon # Nov 01 09:43:03 volumio2 volumio-streaming-daemon[852]: # Running on port 7777 # Nov 01 09:43:03 volumio2 volumio-streaming-daemon[852]: ############################ Nov 01 09:43:03 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:03] [info] asio async_connect error: system:111 (Connection refused) Nov 01 09:43:03 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 01 09:43:03 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:03] [error] handle_connect error: Underlying Transport Error Nov 01 09:43:04 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:04 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:04 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:04 volumio2 systemd[1]: Started Xbindrc. Nov 01 09:43:04 volumio2 hotspot[847]: basename: missing operand Nov 01 09:43:04 volumio2 hotspot[847]: Try 'basename --help' for more information. Nov 01 09:43:05 volumio2 hotspot[847]: Launching Ordinary Hostapd Nov 01 09:43:06 volumio2 hotspot[847]: Configuration file: /etc/hostapd/hostapd.conf Nov 01 09:43:06 volumio2 hotspot[847]: Could not read interface wlan0 flags: No such device Nov 01 09:43:06 volumio2 hotspot[847]: nl80211: Driver does not support authentication/association or connect commands Nov 01 09:43:06 volumio2 hotspot[847]: Could not read interface wlan0 flags: No such device Nov 01 09:43:06 volumio2 hotspot[847]: nl80211 driver initialization failed. Nov 01 09:43:06 volumio2 hotspot[847]: hostapd_free_hapd_data: Interface wlan0 wasn't started Nov 01 09:43:06 volumio2 systemd[1]: hotspot.service: main process exited, code=exited, status=1/FAILURE Nov 01 09:43:06 volumio2 hotspot[893]: Killing Hostapd Nov 01 09:43:06 volumio2 systemd[1]: Stopping Host and Network Name Lookups. Nov 01 09:43:06 volumio2 systemd[1]: Stopped target Host and Network Name Lookups. Nov 01 09:43:06 volumio2 dnsmasq[854]: exiting on receipt of SIGTERM Nov 01 09:43:06 volumio2 systemd[1]: Stopping dnsmasq.service... Nov 01 09:43:06 volumio2 systemd[1]: Stopped dnsmasq.service. Nov 01 09:43:06 volumio2 sudo[895]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall hostapd Nov 01 09:43:06 volumio2 sudo[895]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:43:06 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:07 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:07 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:07 volumio2 systemd[1]: Started Xbindrc. Nov 01 09:43:07 volumio2 hotspot[893]: hostapd: no process found Nov 01 09:43:07 volumio2 sudo[895]: pam_unix(sudo:session): session closed for user root Nov 01 09:43:07 volumio2 systemd[1]: Started Music Player Daemon. Nov 01 09:43:07 volumio2 hotspot[893]: Killing Dhcpd Nov 01 09:43:07 volumio2 sudo[911]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall dhcpd Nov 01 09:43:07 volumio2 sudo[911]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:43:07 volumio2 hotspot[893]: dhcpd: no process found Nov 01 09:43:07 volumio2 sudo[911]: pam_unix(sudo:session): session closed for user root Nov 01 09:43:08 volumio2 systemd[1]: hotspot.service: control process exited, code=exited status=1 Nov 01 09:43:08 volumio2 systemd[1]: Unit hotspot.service entered failed state. Nov 01 09:43:09 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:09 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:09 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:09 volumio2 systemd[1]: Started Xbindrc. Nov 01 09:43:10 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:10 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:10 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:10 volumio2 systemd[1]: Started Xbindrc. Nov 01 09:43:12 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:12 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:12 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:12 volumio2 systemd[1]: Started Xbindrc. Nov 01 09:43:13 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:13 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:13 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:13 volumio2 systemd[1]: Started Xbindrc. Nov 01 09:43:13 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:13] [info] asio async_connect error: system:111 (Connection refused) Nov 01 09:43:13 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:13] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 01 09:43:13 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:13] [error] handle_connect error: Underlying Transport Error Nov 01 09:43:15 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:15 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:15 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:15 volumio2 systemd[1]: Started Xbindrc. Nov 01 09:43:16 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:16 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:16 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:16 volumio2 systemd[1]: Started Xbindrc. Nov 01 09:43:18 volumio2 smbd[867]: Starting SMB/CIFS daemon: smbd[2025/11/01 09:43:18, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:18 volumio2 smbd[867]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 01 09:43:18 volumio2 smbd[867]: [2025/11/01 09:43:18, 0] ../lib/util/util.c:220(directory_create_or_exist) Nov 01 09:43:18 volumio2 smbd[867]: mkdir failed on directory /var/log/samba/cores: No such file or directory Nov 01 09:43:18 volumio2 smbd[867]: [2025/11/01 09:43:18, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Nov 01 09:43:18 volumio2 smbd[867]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Nov 01 09:43:18 volumio2 smbd[867]: [2025/11/01 09:43:18, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Nov 01 09:43:18 volumio2 smbd[867]: Unable to setup corepath for smbd: No such file or directory Nov 01 09:43:18 volumio2 smbd[867]: [2025/11/01 09:43:18, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:18 volumio2 smbd[867]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 01 09:43:18 volumio2 smbd[867]: [2025/11/01 09:43:18, 0] ../source3/smbd/server.c:1241(main) Nov 01 09:43:18 volumio2 smbd[867]: smbd version 4.2.14-Debian started. Nov 01 09:43:18 volumio2 smbd[867]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Nov 01 09:43:18 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:18 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:18 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:18 volumio2 systemd[1]: Started Xbindrc. Nov 01 09:43:18 volumio2 smbd[941]: [2025/11/01 09:43:18.792563, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:18 volumio2 smbd[941]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 01 09:43:18 volumio2 smbd[941]: [2025/11/01 09:43:18.828205, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:18 volumio2 smbd[941]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 01 09:43:18 volumio2 smbd[941]: [2025/11/01 09:43:18.829084, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:18 volumio2 smbd[941]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 01 09:43:18 volumio2 smbd[867]: [2025/11/01 09:43:18.792563, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:18 volumio2 smbd[867]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 01 09:43:18 volumio2 smbd[867]: [2025/11/01 09:43:18.828205, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:18 volumio2 smbd[867]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 01 09:43:18 volumio2 smbd[867]: [2025/11/01 09:43:18.829084, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:18 volumio2 smbd[867]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 01 09:43:18 volumio2 systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Nov 01 09:43:18 volumio2 smbd[867]: . Nov 01 09:43:18 volumio2 systemd[1]: Starting Multi-User System. Nov 01 09:43:18 volumio2 systemd[1]: Reached target Multi-User System. Nov 01 09:43:18 volumio2 systemd[1]: Starting Graphical Interface. Nov 01 09:43:18 volumio2 systemd[1]: Reached target Graphical Interface. Nov 01 09:43:18 volumio2 systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 01 09:43:19 volumio2 systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 01 09:43:19 volumio2 systemd[1]: Startup finished in 9.733s (kernel) + 1min 29.689s (userspace) = 1min 39.422s. Nov 01 09:43:19 volumio2 winbindd[956]: [2025/11/01 09:43:19.490861, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:19 volumio2 winbindd[956]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Nov 01 09:43:19 volumio2 winbindd[957]: [2025/11/01 09:43:19.733152, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:19 volumio2 winbindd[957]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Nov 01 09:43:20 volumio2 smbd[950]: [2025/11/01 09:43:20.158082, 0] ../lib/util/become_daemon.c:124(daemon_ready) Nov 01 09:43:20 volumio2 smbd[950]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 01 09:43:20 volumio2 smbd[958]: [2025/11/01 09:43:20.219007, 0] ../lib/util/debug.c:603(reopen_logs_internal) Nov 01 09:43:20 volumio2 smbd[958]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Nov 01 09:43:20 volumio2 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Nov 01 09:43:20 volumio2 systemd[1]: Stopping Xbindrc... Nov 01 09:43:20 volumio2 systemd[1]: Starting Xbindrc... Nov 01 09:43:20 volumio2 systemd[1]: xbindkeysrc.service start request repeated too quickly, refusing to start. Nov 01 09:43:20 volumio2 systemd[1]: Failed to start Xbindrc. Nov 01 09:43:20 volumio2 systemd[1]: Unit xbindkeysrc.service entered failed state. Nov 01 09:43:23 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:23] [info] asio async_connect error: system:111 (Connection refused) Nov 01 09:43:23 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:23] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 01 09:43:23 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:23] [error] handle_connect error: Underlying Transport Error Nov 01 09:43:26 volumio2 volumio[851]: info: ------------------------------------------- Nov 01 09:43:26 volumio2 volumio[851]: info: ----- Volumio2 ---- Nov 01 09:43:26 volumio2 volumio[851]: info: ------------------------------------------- Nov 01 09:43:26 volumio2 volumio[851]: info: ----- System startup ---- Nov 01 09:43:26 volumio2 volumio[851]: info: ------------------------------------------- Nov 01 09:43:27 volumio2 volumio[851]: info: MYVOLUMIO Environment detected Nov 01 09:43:27 volumio2 volumio[851]: info: Plugin folders cleanup Nov 01 09:43:27 volumio2 volumio[851]: info: Scanning into folder /volumio/app/plugins/ Nov 01 09:43:27 volumio2 volumio[851]: info: Scanning category audio_interface Nov 01 09:43:27 volumio2 volumio[851]: info: Scanning category miscellanea Nov 01 09:43:27 volumio2 volumio[851]: info: Scanning category music_service Nov 01 09:43:27 volumio2 volumio[851]: info: Scanning category plugins.json Nov 01 09:43:27 volumio2 volumio[851]: info: Scanning category system_controller Nov 01 09:43:27 volumio2 volumio[851]: info: Scanning category user_interface Nov 01 09:43:27 volumio2 volumio[851]: info: Scanning into folder /data/plugins/ Nov 01 09:43:27 volumio2 volumio[851]: info: Plugin folders cleanup completed Nov 01 09:43:27 volumio2 volumio[851]: info: ------------------------------------------- Nov 01 09:43:27 volumio2 volumio[851]: info: ----- Core plugins startup ---- Nov 01 09:43:27 volumio2 volumio[851]: info: ------------------------------------------- Nov 01 09:43:27 volumio2 volumio[851]: info: Loading plugins from folder /volumio/app/plugins/ Nov 01 09:43:27 volumio2 volumio[851]: info: Adding plugin upnp to MyMusic Plugins Nov 01 09:43:27 volumio2 volumio[851]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 01 09:43:27 volumio2 volumio[851]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 01 09:43:27 volumio2 volumio[851]: info: Loading plugins from folder /data/plugins/ Nov 01 09:43:27 volumio2 volumio[851]: info: Loading plugin "system"... Nov 01 09:43:27 volumio2 volumio[851]: info: Loading plugin "appearance"... Nov 01 09:43:33 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:33] [connect] Successful connection Nov 01 09:43:34 volumio2 volumio[851]: info: Loading plugin "network"... Nov 01 09:43:36 volumio2 volumio[851]: info: Loading plugin "services"... Nov 01 09:43:36 volumio2 volumio[851]: info: Loading plugin "alsa_controller"... Nov 01 09:43:37 volumio2 volumio[851]: info: Loading plugin "wizard"... Nov 01 09:43:37 volumio2 volumio[851]: info: Loading plugin "volumio_command_line_client"... Nov 01 09:43:37 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 09:43:37 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 09:43:37 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 09:43:37 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 09:43:37 volumio2 volumio[851]: info: Loading plugin "upnp"... Nov 01 09:43:37 volumio2 volumio[851]: info: [1761990217265] Starting Upmpd Daemon Nov 01 09:43:37 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 01 09:43:37 volumio2 volumio[851]: info: Loading plugin "my_music"... Nov 01 09:43:37 volumio2 volumio[851]: info: Loading plugin "mpd"... Nov 01 09:43:39 volumio2 volumio[851]: info: Loading plugin "upnp_browser"... Nov 01 09:43:45 volumio2 volumio[851]: info: Loading plugin "networkfs"... Nov 01 09:43:46 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 01 09:43:46 volumio2 volumio[851]: info: Loading plugin "alarm-clock"... Nov 01 09:43:46 volumio2 sudo[976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Mario_C,password=MCgives55!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.118/Multimedia\music_flac /mnt/NAS/NAS2 Nov 01 09:43:46 volumio2 sudo[976]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:43:47 volumio2 kernel: FS-Cache: Netfs 'cifs' registered for caching Nov 01 09:43:47 volumio2 kernel: Key type cifs.spnego registered Nov 01 09:43:47 volumio2 kernel: Key type cifs.idmap registered Nov 01 09:43:47 volumio2 kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Nov 01 09:43:47 volumio2 kernel: CIFS VFS: ioctl error in smb2_get_dfs_refer rc=-2 Nov 01 09:43:47 volumio2 sudo[976]: pam_unix(sudo:session): session closed for user root Nov 01 09:43:48 volumio2 volumio[851]: info: Loading plugin "airplay_emulation"... Nov 01 09:43:48 volumio2 volumio[851]: info: Starting Shairport Sync Nov 01 09:43:48 volumio2 volumio[851]: info: Loading plugin "last_100"... Nov 01 09:43:48 volumio2 volumio[851]: info: Loading plugin "webradio"... Nov 01 09:43:48 volumio2 volumio[851]: info: Loading plugin "i2s_dacs"... Nov 01 09:43:48 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 09:43:48 volumio2 volumio[851]: info: Loading plugin "volumiodiscovery"... Nov 01 09:43:48 volumio2 volumio-remote-updater[584]: [2025-11-01 09:43:48] [connect] Successful connection Nov 01 09:43:49 volumio2 volumio[851]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 01 09:43:49 volumio2 node[851]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 01 09:43:49 volumio2 node[851]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 01 09:43:49 volumio2 node[851]: *** WARNING *** For more information see Nov 01 09:43:49 volumio2 node[851]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 01 09:43:49 volumio2 node[851]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 01 09:43:49 volumio2 node[851]: *** WARNING *** For more information see Nov 01 09:43:49 volumio2 volumio[851]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 01 09:43:49 volumio2 volumio[851]: *** WARNING *** For more information see Nov 01 09:43:49 volumio2 volumio[851]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 01 09:43:49 volumio2 volumio[851]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 01 09:43:49 volumio2 volumio[851]: *** WARNING *** For more information see Nov 01 09:43:49 volumio2 volumio[851]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 01 09:43:49 volumio2 volumio[851]: Discovery: StartAdv! undefined Nov 01 09:43:49 volumio2 volumio[851]: Discovery: Started advertising... undefined - undefined Nov 01 09:43:49 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 01 09:43:49 volumio2 volumio[851]: info: Loading plugin "outputs"... Nov 01 09:43:49 volumio2 volumio[851]: info: Loading plugin "albumart"... Nov 01 09:43:49 volumio2 volumio[851]: info: Plugin example_plugin is not enabled Nov 01 09:43:49 volumio2 volumio[851]: info: Loading plugin "inputs"... Nov 01 09:43:49 volumio2 volumio[851]: info: Loading plugin "updater_comm"... Nov 01 09:43:51 volumio2 volumio[851]: info: Plugin mpdemulation is not enabled Nov 01 09:43:51 volumio2 volumio[851]: info: Loading plugin "rest_api"... Nov 01 09:43:52 volumio2 volumio[851]: info: Loading plugin "websocket"... Nov 01 09:43:52 volumio2 volumio[851]: info: ___________ START PLUGINS ___________ Nov 01 09:43:52 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 09:43:52 volumio2 volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 01 09:43:52 volumio2 volumio[851]: info: [1761990232505] CoreMusicLibrary::Adding element Media Servers Nov 01 09:43:52 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 09:43:52 volumio2 volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 01 09:43:52 volumio2 volumio[851]: info: [1761990232884] CoreMusicLibrary::Adding element Last_100 Nov 01 09:43:52 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 09:43:52 volumio2 volumio[851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 01 09:43:52 volumio2 volumio[851]: info: [1761990232921] CoreMusicLibrary::Adding element Webradio Nov 01 09:43:52 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 09:43:52 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 01 09:43:53 volumio2 volumio[851]: info: ------------------------------------------- Nov 01 09:43:53 volumio2 volumio[851]: info: ----- MyVolumio plugins startup ---- Nov 01 09:43:53 volumio2 volumio[851]: info: ------------------------------------------- Nov 01 09:43:53 volumio2 volumio[851]: info: Loading plugins from folder /myvolumio/plugins Nov 01 09:43:53 volumio2 volumio[851]: info: Loading plugins from folder /data/myvolumio/plugins Nov 01 09:43:53 volumio2 volumio[851]: info: Loading plugin "cd_controller"... Nov 01 09:43:53 volumio2 volumio[851]: info: Loading plugin "streaming_services"... Nov 01 09:43:53 volumio2 volumio[851]: Forking 1 albumart workers Nov 01 09:43:56 volumio2 volumio[851]: info: Loading plugin "my_volumio"... Nov 01 09:44:03 volumio2 volumio[851]: Starting albumart workers Nov 01 09:44:03 volumio2 volumio-remote-updater[584]: [2025-11-01 09:44:03] [connect] Successful connection Nov 01 09:44:04 volumio2 volumio[851]: info: Adding CD REST API Endpoints Nov 01 09:44:04 volumio2 volumio[851]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Nov 01 09:44:04 volumio2 volumio[851]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Nov 01 09:44:04 volumio2 volumio[851]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Nov 01 09:44:04 volumio2 volumio[851]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Nov 01 09:44:04 volumio2 volumio[851]: info: Detecting CD presence Nov 01 09:44:04 volumio2 volumio[851]: info: Streaming services startup Nov 01 09:44:04 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 09:44:04 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 09:44:04 volumio2 volumio[851]: info: Starting MyVolumio Remote Streaming Endpoints Nov 01 09:44:04 volumio2 sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 01 09:44:04 volumio2 sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 09:44:05 volumio2 systemd[1]: Stopping Volumio Streaming Daemon... Nov 01 09:44:05 volumio2 systemd[1]: Starting Volumio Streaming Daemon... Nov 01 09:44:05 volumio2 systemd[1]: Started Volumio Streaming Daemon. Nov 01 09:44:05 volumio2 sudo[1028]: pam_unix(sudo:session): session closed for user root Nov 01 09:44:05 volumio2 volumio-streaming-daemon[1034]: ############################ Nov 01 09:44:05 volumio2 volumio-streaming-daemon[1034]: # Volumio Streaming Daemon # Nov 01 09:44:05 volumio2 volumio-streaming-daemon[1034]: # Running on port 7777 # Nov 01 09:44:05 volumio2 volumio-streaming-daemon[1034]: ############################ Nov 01 09:44:05 volumio2 volumio[851]: info: Loading i18n strings for locale en Nov 01 09:44:05 volumio2 volumio[851]: Updating browse sources language Nov 01 09:44:05 volumio2 volumio[851]: Cannot find translation for sourceMedia Servers Nov 01 09:44:05 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 09:44:05 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 09:44:05 volumio2 volumio[851]: info: CoreCommandRouter::initPlayerControls Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 09:44:06 volumio2 volumio[851]: info: BOOT COMPLETED Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::Close All Modals sent Nov 01 09:44:06 volumio2 volumio[851]: info: CoreCommandRouter::Close All Modals sent Nov 01 09:44:06 volumio2 volumio[851]: Express server listening on port 3000 Nov 01 09:44:06 volumio2 volumio[851]: Volumio Calling Home Nov 01 09:44:07 volumio2 volumio[851]: info: MyVolumio not started Nov 01 09:44:07 volumio2 volumio[851]: info: CoreStateMachine::resetVolumioState Nov 01 09:44:07 volumio2 volumio[851]: info: CoreStateMachine::getcurrentVolume Nov 01 09:44:07 volumio2 volumio[851]: info: CoreCommandRouter::volumioRetrievevolume Nov 01 09:44:07 volumio2 volumio[851]: info: CoreStateMachine::pushState Nov 01 09:44:07 volumio2 volumio[851]: info: CoreStateMachine::getState Nov 01 09:44:07 volumio2 volumio[851]: info: CorePlayQueue::getTrack 0 Nov 01 09:44:07 volumio2 volumio[851]: info: CoreCommandRouter::volumioPushState Nov 01 09:44:07 volumio2 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 09:44:08 volumio2 volumio[851]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 09:44:08 volumio2 volumio[851]: TypeError: Cannot read property 'charAt' of undefined Nov 01 09:44:08 volumio2 volumio[851]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:208:28) Nov 01 09:44:08 volumio2 volumio[851]: at ontimeout (timers.js:482:11) Nov 01 09:44:08 volumio2 volumio[851]: at tryOnTimeout (timers.js:317:5) Nov 01 09:44:08 volumio2 volumio[851]: at Timer.listOnTimeout (timers.js:277:5) Nov 01 09:44:08 volumio2 volumio[851]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 09:44:13 volumio2 sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-01 09:43 Nov 01 09:44:13 volumio2 sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="fe83e03fe4a5ad6387f0fd162f915b7fc3065a36" VOLUMIO_FE_VERSION="3927cf879718a0297ddabc3805589c385dd4c7bd" VOLUMIO_BE_VERSION="d57008595633b428eec7784fea777242fe1c15ac" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Apr 23 20:16:23 CEST 2019" VOLUMIO_VERSION="2.575" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5b62cf8f91d8d86f894459ee8b534ab5"