-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2025-03-20 15:51:05 CST. --
Mar 20 15:50:02 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:02 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:02 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:07 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:07 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:07 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:12 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:12 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:12 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:17 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:17 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:17 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:22 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:22 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:22 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:27 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:27 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:27 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:32 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:32 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:32 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:37 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:37 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:37 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:40 smsl-n100 ntpd[763]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Mar 20 15:50:42 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:42 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:42 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:43 smsl-n100 ntpd[763]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Mar 20 15:50:44 smsl-n100 ntpd[763]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Mar 20 15:50:47 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:47 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:47 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:50 smsl-n100 ntpd[763]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Mar 20 15:50:51 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off
Mar 20 15:50:51 smsl-n100 dhcpcd[601]: eth0: carrier acquired
Mar 20 15:50:51 smsl-n100 dhcpcd[601]: eth0: IAID a9:85:45:06
Mar 20 15:50:52 smsl-n100 dhcpcd[601]: eth0: soliciting an IPv6 router
Mar 20 15:50:52 smsl-n100 ifplugd(eth0)[751]: Link beat detected.
Mar 20 15:50:52 smsl-n100 dhcpcd[601]: eth0: rebinding lease of 192.168.0.20
Mar 20 15:50:52 smsl-n100 dhcpcd[601]: eth0: NAK: REQUEST for invalid Requested IP Address from 192.168.1.1
Mar 20 15:50:52 smsl-n100 dhcpcd[601]: eth0: message: REQUEST for invalid Requested IP Address
Mar 20 15:50:52 smsl-n100 ifplugd(eth0)[751]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Mar 20 15:50:52 smsl-n100 dhcpcd[601]: eth0: soliciting a DHCP lease
Mar 20 15:50:52 smsl-n100 ifplugd(eth0)[751]: client: sending commands to master dhcpcd process
Mar 20 15:50:52 smsl-n100 dhcpcd[2119]: sending commands to master dhcpcd process
Mar 20 15:50:52 smsl-n100 dhcpcd[601]: control command: /sbin/dhcpcd eth0
Mar 20 15:50:52 smsl-n100 ifplugd(eth0)[751]: Program executed successfully.
Mar 20 15:50:53 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:53 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:53 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:50:57 smsl-n100 dhcpcd[601]: eth0: probing for an IPv4LL address
Mar 20 15:50:58 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:50:58 smsl-n100 dhcpcd[601]: eth0: offered 192.168.1.11 from 192.168.1.1
Mar 20 15:50:58 smsl-n100 dhcpcd[601]: eth0: probing address 192.168.1.11/24
Mar 20 15:50:58 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Date not found in response
Mar 20 15:50:58 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Retrying in 5 seconds...
Mar 20 15:51:02 smsl-n100 dhcpcd[601]: eth0: using IPv4LL address 169.254.30.108
Mar 20 15:51:02 smsl-n100 dhcpcd[601]: eth0: adding route to 169.254.0.0/16
Mar 20 15:51:02 smsl-n100 dhcpcd[601]: eth0: adding default route
Mar 20 15:51:02 smsl-n100 avahi-daemon[559]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.30.108.
Mar 20 15:51:02 smsl-n100 avahi-daemon[559]: New relevant interface eth0.IPv4 for mDNS.
Mar 20 15:51:02 smsl-n100 avahi-daemon[559]: Registering new address record for 169.254.30.108 on eth0.IPv4.
Mar 20 15:51:03 smsl-n100 volumio-time-update[555]: volumio-time-update-util: Fetching time from Volumio...
Mar 20 15:51:03 smsl-n100 dhcpcd[601]: eth0: leased 192.168.1.11 for 86400 seconds
Mar 20 15:51:03 smsl-n100 dhcpcd[601]: eth0: adding route to 192.168.1.0/24
Mar 20 15:51:03 smsl-n100 avahi-daemon[559]: Registering new address record for 192.168.1.11 on eth0.IPv4.
Mar 20 15:51:03 smsl-n100 dhcpcd[601]: eth0: changing default route via 192.168.1.1
Mar 20 15:51:03 smsl-n100 ntpd[763]: ntpd exiting on signal 15 (Terminated)
Mar 20 15:51:03 smsl-n100 systemd[1]: Stopping Network Time Service...
Mar 20 15:51:03 smsl-n100 systemd[1]: ntp.service: Succeeded.
Mar 20 15:51:03 smsl-n100 systemd[1]: Stopped Network Time Service.
Mar 20 15:51:03 smsl-n100 systemd[1]: Starting Network Time Service...
Mar 20 15:51:03 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 20 15:51:03 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Mar 20 15:51:03 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 20 15:51:03 smsl-n100 ntpd[2225]: ntpd 4.2.8p12@1.3728-o (1): Starting
Mar 20 15:51:03 smsl-n100 ntpd[2225]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Mar 20 15:51:03 smsl-n100 systemd[1]: Started Network Time Service.
Mar 20 15:51:03 smsl-n100 dhcpcd[601]: eth0: deleting route to 169.254.0.0/16
Mar 20 15:51:03 smsl-n100 avahi-daemon[559]: Withdrawing address record for 169.254.30.108 on eth0.
Mar 20 15:51:03 smsl-n100 avahi-daemon[559]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.30.108.
Mar 20 15:51:03 smsl-n100 avahi-daemon[559]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.11.
Mar 20 15:51:03 smsl-n100 ntpd[2231]: proto: precision = 1.166 usec (-20)
Mar 20 15:51:03 smsl-n100 ntpd[2231]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Mar 20 15:51:03 smsl-n100 ntpd[2231]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Mar 20 15:51:03 smsl-n100 ntpd[2231]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 814 days ago
Mar 20 15:51:03 smsl-n100 ntpd[2231]: Listen and drop on 0 v6wildcard [::]:123
Mar 20 15:51:03 smsl-n100 ntpd[2231]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Mar 20 15:51:03 smsl-n100 ntpd[2231]: Listen normally on 2 lo 127.0.0.1:123
Mar 20 15:51:03 smsl-n100 ntpd[2231]: Listen normally on 3 eth0 192.168.1.11:123
Mar 20 15:51:03 smsl-n100 ntpd[2231]: Listening on routing socket on fd #20 for interface updates
Mar 20 15:51:03 smsl-n100 ntpd[2231]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Mar 20 15:51:03 smsl-n100 ntpd[2231]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Mar 20 15:51:03 smsl-n100 volumio[956]: info: Discovery: adding d19613fa-5c2e-4618-b598-9ab8ba134bde
Mar 20 15:51:03 smsl-n100 volumio[956]: info: Discovery: Found device SMSL N100
Mar 20 15:51:03 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioGetState
Mar 20 15:51:03 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0
Mar 20 15:51:03 smsl-n100 volumio[956]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 20 15:51:03 smsl-n100 volumio[956]: Error: The value NaN is not a number
Mar 20 15:51:03 smsl-n100 volumio[956]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20)
Mar 20 15:51:03 smsl-n100 volumio[956]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25)
Mar 20 15:51:03 smsl-n100 volumio[956]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25)
Mar 20 15:51:03 smsl-n100 volumio[956]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10)
Mar 20 15:51:03 smsl-n100 volumio[956]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12)
Mar 20 15:51:03 smsl-n100 volumio[956]: at Browser.emit (events.js:400:28)
Mar 20 15:51:03 smsl-n100 volumio[956]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14)
Mar 20 15:51:03 smsl-n100 volumio[956]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7)
Mar 20 15:51:03 smsl-n100 volumio[956]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5)
Mar 20 15:51:03 smsl-n100 volumio[956]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21)
Mar 20 15:51:03 smsl-n100 volumio[956]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11
Mar 20 15:51:03 smsl-n100 volumio[956]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7)
Mar 20 15:51:03 smsl-n100 volumio[956]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9)
Mar 20 15:51:03 smsl-n100 volumio[956]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 20 15:51:05 smsl-n100 ntpd[2231]: Soliciting pool server 193.59.134.156
Mar 20 15:51:05 smsl-n100 sudo[2259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-20 15:50
Mar 20 15:51:05 smsl-n100 sudo[2259]: 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="8205c9d25502d90d2bb411bb156e1d5a8ef7404e"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="smsl"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 20 Jan 2025 07:23:13 PM CET"
VOLUMIO_VERSION="3.788"
VOLUMIO_HARDWARE="nanopineo3"
VOLUMIO_DEVICENAME="Nanopi Neo3"
VOLUMIO_VENDOR_MODEL="SMSL S100"
VOLUMIO_VENDOR="SMSL"
VOLUMIO_MODEL="S100"
VOLUMIO_HASH="b3195a7f5841a4bc08e3e196c1a91b34"