-- Logs begin at Mon 2025-10-27 16:13:38 JST, end at Wed 2025-10-29 13:27:25 JST. --
Oct 29 13:27:13 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Down
Oct 29 13:27:13 smsl-n100 dhcpcd[908]: eth0: carrier lost
Oct 29 13:27:13 smsl-n100 dhcpcd[924]: eth0: carrier lost
Oct 29 13:27:13 smsl-n100 avahi-daemon[567]: Withdrawing address record for 192.168.0.9 on eth0.
Oct 29 13:27:13 smsl-n100 avahi-daemon[567]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.9.
Oct 29 13:27:13 smsl-n100 avahi-daemon[567]: Interface eth0.IPv4 no longer relevant for mDNS.
Oct 29 13:27:13 smsl-n100 dhcpcd[908]: eth0: deleting route to 192.168.0.0/24
Oct 29 13:27:13 smsl-n100 dhcpcd[924]: eth0: deleting route to 192.168.0.0/24
Oct 29 13:27:13 smsl-n100 dhcpcd[924]: eth0: deleting default route via 192.168.0.1
Oct 29 13:27:13 smsl-n100 dhcpcd[908]: eth0: deleting default route via 192.168.0.1
Oct 29 13:27:13 smsl-n100 volumio[802]: info: Discovery: A device disappeared from network
Oct 29 13:27:13 smsl-n100 ifplugd(eth0)[746]: Link beat lost.
Oct 29 13:27:13 smsl-n100 volumio[802]: info: Reporting MCU Network Status: 0
Oct 29 13:27:13 smsl-n100 volumio[802]: info: Volumio Network Manager: Network status updated: 0
Oct 29 13:27:13 smsl-n100 volumio[802]: info: CoreStateMachine::pushState
Oct 29 13:27:13 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 29 13:27:13 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioPushState
Oct 29 13:27:13 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output update for this device
Oct 29 13:27:13 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output
Oct 29 13:27:13 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: 100, message: undefined
Oct 29 13:27:13 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: MAXVOL, message:
Oct 29 13:27:13 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: 100, message: undefined
Oct 29 13:27:13 smsl-n100 volumio[802]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Oct 29 13:27:13 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: 0, message: undefined
Oct 29 13:27:14 smsl-n100 ntpd[21306]: Deleting interface #3 eth0, 192.168.0.9#123, interface stats: received=957, sent=965, dropped=0, active_time=13649 secs
Oct 29 13:27:14 smsl-n100 ntpd[21306]: 124.159.225.181 local addr 192.168.0.9 -> 
Oct 29 13:27:14 smsl-n100 ntpd[21306]: 103.173.178.156 local addr 192.168.0.9 -> 
Oct 29 13:27:14 smsl-n100 ntpd[21306]: 172.104.124.149 local addr 192.168.0.9 -> 
Oct 29 13:27:14 smsl-n100 ntpd[21306]: 167.179.119.205 local addr 192.168.0.9 -> 
Oct 29 13:27:14 smsl-n100 ntpd[21306]: 160.25.135.55 local addr 192.168.0.9 -> 
Oct 29 13:27:14 smsl-n100 ntpd[21306]: 202.181.103.212 local addr 192.168.0.9 -> 
Oct 29 13:27:18 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
Oct 29 13:27:18 smsl-n100 dhcpcd[924]: eth0: carrier acquired
Oct 29 13:27:18 smsl-n100 dhcpcd[908]: eth0: carrier acquired
Oct 29 13:27:18 smsl-n100 dhcpcd[908]: eth0: IAID 16:46:83:8b
Oct 29 13:27:18 smsl-n100 dhcpcd[924]: eth0: IAID 16:46:83:8b
Oct 29 13:27:18 smsl-n100 dhcpcd[924]: eth0: soliciting an IPv6 router
Oct 29 13:27:18 smsl-n100 ifplugd(eth0)[746]: Link beat detected.
Oct 29 13:27:18 smsl-n100 dhcpcd[908]: eth0: rebinding lease of 192.168.0.9
Oct 29 13:27:19 smsl-n100 dhcpcd[924]: eth0: rebinding lease of 192.168.0.9
Oct 29 13:27:19 smsl-n100 dhcpcd[908]: eth0: probing address 192.168.0.9/24
Oct 29 13:27:19 smsl-n100 dhcpcd[908]: eth0: soliciting an IPv6 router
Oct 29 13:27:19 smsl-n100 dhcpcd[924]: eth0: probing address 192.168.0.9/24
Oct 29 13:27:23 smsl-n100 dhcpcd[924]: eth0: leased 192.168.0.9 for 86400 seconds
Oct 29 13:27:23 smsl-n100 dhcpcd[924]: eth0: adding route to 192.168.0.0/24
Oct 29 13:27:23 smsl-n100 dhcpcd[924]: eth0: adding default route via 192.168.0.1
Oct 29 13:27:23 smsl-n100 avahi-daemon[567]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.9.
Oct 29 13:27:23 smsl-n100 avahi-daemon[567]: New relevant interface eth0.IPv4 for mDNS.
Oct 29 13:27:23 smsl-n100 avahi-daemon[567]: Registering new address record for 192.168.0.9 on eth0.IPv4.
Oct 29 13:27:24 smsl-n100 volumio[802]: info: MRS: Found cast device: BRAVIA-4K-UR3-582241f907d40aaf90b5e59216c25598
Oct 29 13:27:24 smsl-n100 volumio[802]: info: MRS: Found cast device: BRAVIA-4K-VH21-00ef40ae97ec01d0656882168d402d92
Oct 29 13:27:24 smsl-n100 ntpd[21306]: ntpd exiting on signal 15 (Terminated)
Oct 29 13:27:24 smsl-n100 systemd[1]: Stopping Network Time Service...
Oct 29 13:27:24 smsl-n100 systemd[1]: ntp.service: Succeeded.
Oct 29 13:27:24 smsl-n100 systemd[1]: Stopped Network Time Service.
Oct 29 13:27:24 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 29 13:27:24 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Oct 29 13:27:24 smsl-n100 systemd[1]: Starting Network Time Service...
Oct 29 13:27:24 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 29 13:27:24 smsl-n100 ntpd[16153]: ntpd 4.2.8p12@1.3728-o (1): Starting
Oct 29 13:27:24 smsl-n100 ntpd[16153]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Oct 29 13:27:24 smsl-n100 systemd[1]: Started Network Time Service.
Oct 29 13:27:24 smsl-n100 ntpd[16160]: proto: precision = 1.166 usec (-20)
Oct 29 13:27:24 smsl-n100 ntpd[16160]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Oct 29 13:27:24 smsl-n100 ntpd[16160]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Oct 29 13:27:24 smsl-n100 ntpd[16160]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1037 days ago
Oct 29 13:27:24 smsl-n100 ntpd[16160]: Listen and drop on 0 v6wildcard [::]:123
Oct 29 13:27:24 smsl-n100 ntpd[16160]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Oct 29 13:27:24 smsl-n100 ntpd[16160]: Listen normally on 2 lo 127.0.0.1:123
Oct 29 13:27:24 smsl-n100 ntpd[16160]: Listen normally on 3 eth0 192.168.0.9:123
Oct 29 13:27:24 smsl-n100 ntpd[16160]: Listening on routing socket on fd #20 for interface updates
Oct 29 13:27:24 smsl-n100 ntpd[16160]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Oct 29 13:27:24 smsl-n100 ntpd[16160]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Oct 29 13:27:24 smsl-n100 dhcpcd[908]: eth0: leased 192.168.0.9 for 86400 seconds
Oct 29 13:27:24 smsl-n100 dhcpcd[908]: eth0: adding route to 192.168.0.0/24
Oct 29 13:27:24 smsl-n100 dhcpcd[908]: eth0: adding default route via 192.168.0.1
Oct 29 13:27:24 smsl-n100 ntpd[16160]: ntpd exiting on signal 15 (Terminated)
Oct 29 13:27:24 smsl-n100 systemd[1]: Stopping Network Time Service...
Oct 29 13:27:24 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 29 13:27:24 smsl-n100 systemd[1]: ntp.service: Succeeded.
Oct 29 13:27:24 smsl-n100 systemd[1]: Stopped Network Time Service.
Oct 29 13:27:24 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Oct 29 13:27:24 smsl-n100 systemd[1]: Starting Network Time Service...
Oct 29 13:27:24 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: running
Oct 29 13:27:24 smsl-n100 ntpd[16193]: ntpd 4.2.8p12@1.3728-o (1): Starting
Oct 29 13:27:24 smsl-n100 ntpd[16193]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Oct 29 13:27:24 smsl-n100 systemd[1]: Started Network Time Service.
Oct 29 13:27:24 smsl-n100 ntpd[16200]: proto: precision = 1.166 usec (-20)
Oct 29 13:27:24 smsl-n100 ntpd[16200]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Oct 29 13:27:24 smsl-n100 ntpd[16200]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Oct 29 13:27:24 smsl-n100 ntpd[16200]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1037 days ago
Oct 29 13:27:24 smsl-n100 ntpd[16200]: Listen and drop on 0 v6wildcard [::]:123
Oct 29 13:27:24 smsl-n100 ntpd[16200]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Oct 29 13:27:24 smsl-n100 ntpd[16200]: Listen normally on 2 lo 127.0.0.1:123
Oct 29 13:27:24 smsl-n100 ntpd[16200]: Listen normally on 3 eth0 192.168.0.9:123
Oct 29 13:27:24 smsl-n100 ntpd[16200]: Listening on routing socket on fd #20 for interface updates
Oct 29 13:27:24 smsl-n100 ntpd[16200]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Oct 29 13:27:24 smsl-n100 ntpd[16200]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Oct 29 13:27:24 smsl-n100 volumio[802]: info: Discovery: adding d8e8c0e1-ad43-42c8-b87b-48fc050e5760
Oct 29 13:27:24 smsl-n100 volumio[802]: info: Discovery: Found device SMSL N100
Oct 29 13:27:24 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioGetState
Oct 29 13:27:24 smsl-n100 volumio[802]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 29 13:27:24 smsl-n100 volumio[802]: Error: The value NaN is not a number
Oct 29 13:27:24 smsl-n100 volumio[802]:     at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at Config.set (/volumio/node_modules/v-conf/index.js:153:25)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at Browser.emit (events.js:400:28)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at next (/volumio/node_modules/mdns/lib/browser.js:106:7)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at next (/volumio/node_modules/mdns/lib/browser.js:109:21)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11
Oct 29 13:27:24 smsl-n100 volumio[802]:     at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7)
Oct 29 13:27:24 smsl-n100 volumio[802]:     at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9)
Oct 29 13:27:24 smsl-n100 volumio[802]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 29 13:27:25 smsl-n100 sudo[16215]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-29 13:26
Oct 29 13:27:25 smsl-n100 sudo[16215]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="smsl"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET"
VOLUMIO_VERSION="3.789"
VOLUMIO_HARDWARE="nanopineo3"
VOLUMIO_DEVICENAME="Nanopi Neo3"
VOLUMIO_VENDOR_MODEL="SMSL S100"
VOLUMIO_VENDOR="SMSL"
VOLUMIO_MODEL="S100"
VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"