-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Sat 2025-09-06 20:43:52 MSK. --
Sep 06 20:42:02 smsl-n100 ntpd[768]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Sep 06 20:42:03 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:03 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:03 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:03 smsl-n100 ntpd[768]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Sep 06 20:42:07 smsl-n100 ntpd[768]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Sep 06 20:42:08 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:08 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:08 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:08 smsl-n100 ntpd[768]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Sep 06 20:42:13 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:13 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:13 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:18 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:18 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:18 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:23 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:23 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:23 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:28 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:28 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:28 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:33 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:33 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:33 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:38 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:38 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:38 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:43 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:43 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:43 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:48 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:48 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:48 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:53 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:53 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:53 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:42:58 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:42:58 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:42:58 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:03 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:43:03 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:43:03 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:08 smsl-n100 ntpd[768]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Sep 06 20:43:08 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:43:08 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:43:08 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:09 smsl-n100 ntpd[768]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Sep 06 20:43:13 smsl-n100 ntpd[768]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Sep 06 20:43:13 smsl-n100 ntpd[768]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Sep 06 20:43:13 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:43:13 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:43:13 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:18 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:43:18 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:43:18 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:23 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:43:23 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:43:23 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:28 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:43:28 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:43:28 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:33 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:43:33 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:43:33 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:38 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:43:39 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:43:39 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:44 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:43:44 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:43:44 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:44 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx
Sep 06 20:43:44 smsl-n100 dhcpcd[555]: eth0: carrier acquired
Sep 06 20:43:44 smsl-n100 dhcpcd[555]: eth0: IAID 05:c5:83:0b
Sep 06 20:43:45 smsl-n100 ifplugd(eth0)[765]: Link beat detected.
Sep 06 20:43:45 smsl-n100 dhcpcd[555]: eth0: soliciting an IPv6 router
Sep 06 20:43:45 smsl-n100 ifplugd(eth0)[765]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Sep 06 20:43:45 smsl-n100 ifplugd(eth0)[765]: client: ifup: interface eth0 already configured
Sep 06 20:43:45 smsl-n100 ifplugd(eth0)[765]: Program executed successfully.
Sep 06 20:43:45 smsl-n100 dhcpcd[555]: eth0: rebinding lease of 192.168.1.184
Sep 06 20:43:45 smsl-n100 dhcpcd[555]: eth0: probing address 192.168.1.184/24
Sep 06 20:43:49 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Fetching time from Volumio...
Sep 06 20:43:49 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Date not found in response
Sep 06 20:43:49 smsl-n100 volumio-time-update[478]: volumio-time-update-util: Retrying in 5 seconds...
Sep 06 20:43:50 smsl-n100 dhcpcd[555]: eth0: leased 192.168.1.184 for 86400 seconds
Sep 06 20:43:50 smsl-n100 avahi-daemon[474]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.184.
Sep 06 20:43:50 smsl-n100 avahi-daemon[474]: New relevant interface eth0.IPv4 for mDNS.
Sep 06 20:43:50 smsl-n100 dhcpcd[555]: eth0: adding route to 192.168.1.0/24
Sep 06 20:43:50 smsl-n100 avahi-daemon[474]: Registering new address record for 192.168.1.184 on eth0.IPv4.
Sep 06 20:43:50 smsl-n100 dhcpcd[555]: eth0: adding default route via 192.168.1.1
Sep 06 20:43:50 smsl-n100 volumio[960]: verbose: New Socket.io Connection to 192.168.1.184 from 192.168.1.210 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Sep 06 20:43:50 smsl-n100 volumio[960]: verbose: New Socket.io Connection to 192.168.1.184 from 192.168.1.210 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 06 20:43:50 smsl-n100 volumio[960]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Sep 06 20:43:50 smsl-n100 volumio[960]: info: Received Get System Info
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 20:43:50 smsl-n100 volumio[960]: info: Discovery: Getting this device information
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState
Sep 06 20:43:50 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0
Sep 06 20:43:50 smsl-n100 volumio[960]: info: Listing playlists
Sep 06 20:43:50 smsl-n100 volumio[960]: info: MRS: Found cast device: HAKO-Pro-286deb747ae52290a855e2b600aa5373
Sep 06 20:43:50 smsl-n100 volumio[960]: info: Adding audio output:
Sep 06 20:43:50 smsl-n100 ntpd[768]: ntpd exiting on signal 15 (Terminated)
Sep 06 20:43:50 smsl-n100 systemd[1]: Stopping Network Time Service...
Sep 06 20:43:50 smsl-n100 systemd[1]: ntp.service: Succeeded.
Sep 06 20:43:50 smsl-n100 systemd[1]: Stopped Network Time Service.
Sep 06 20:43:50 smsl-n100 volumio[960]: ------------------------------------ BT MESSAGE: BT STATUS: running
Sep 06 20:43:50 smsl-n100 systemd[1]: Starting Network Time Service...
Sep 06 20:43:50 smsl-n100 volumio[960]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Sep 06 20:43:50 smsl-n100 volumio[960]: ------------------------------------ BT MESSAGE: BT STATUS: running
Sep 06 20:43:50 smsl-n100 ntpd[2527]: ntpd 4.2.8p12@1.3728-o (1): Starting
Sep 06 20:43:50 smsl-n100 ntpd[2527]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Sep 06 20:43:50 smsl-n100 systemd[1]: Started Network Time Service.
Sep 06 20:43:50 smsl-n100 ntpd[2534]: proto: precision = 1.166 usec (-20)
Sep 06 20:43:50 smsl-n100 ntpd[2534]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Sep 06 20:43:50 smsl-n100 ntpd[2534]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Sep 06 20:43:50 smsl-n100 ntpd[2534]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 984 days ago
Sep 06 20:43:50 smsl-n100 ntpd[2534]: Listen and drop on 0 v6wildcard [::]:123
Sep 06 20:43:50 smsl-n100 ntpd[2534]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Sep 06 20:43:50 smsl-n100 ntpd[2534]: Listen normally on 2 lo 127.0.0.1:123
Sep 06 20:43:50 smsl-n100 ntpd[2534]: Listen normally on 3 eth0 192.168.1.184:123
Sep 06 20:43:50 smsl-n100 ntpd[2534]: Listening on routing socket on fd #20 for interface updates
Sep 06 20:43:50 smsl-n100 ntpd[2534]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Sep 06 20:43:50 smsl-n100 ntpd[2534]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Sep 06 20:43:51 smsl-n100 volumio[960]: info: Discovery: adding 21034a1d-9c5a-4769-b03f-295abb34199e
Sep 06 20:43:51 smsl-n100 volumio[960]: info: Discovery: Found device SMSL N100
Sep 06 20:43:51 smsl-n100 volumio[960]: info: CoreCommandRouter::volumioGetState
Sep 06 20:43:51 smsl-n100 volumio[960]: info: CorePlayQueue::getTrack 0
Sep 06 20:43:51 smsl-n100 volumio[960]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 20:43:51 smsl-n100 volumio[960]: Error: The value NaN is not a number
Sep 06 20:43:51 smsl-n100 volumio[960]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20)
Sep 06 20:43:51 smsl-n100 volumio[960]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25)
Sep 06 20:43:51 smsl-n100 volumio[960]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25)
Sep 06 20:43:51 smsl-n100 volumio[960]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10)
Sep 06 20:43:51 smsl-n100 volumio[960]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12)
Sep 06 20:43:51 smsl-n100 volumio[960]: at Browser.emit (events.js:400:28)
Sep 06 20:43:51 smsl-n100 volumio[960]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14)
Sep 06 20:43:51 smsl-n100 volumio[960]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7)
Sep 06 20:43:51 smsl-n100 volumio[960]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5)
Sep 06 20:43:51 smsl-n100 volumio[960]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21)
Sep 06 20:43:51 smsl-n100 volumio[960]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11
Sep 06 20:43:51 smsl-n100 volumio[960]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7)
Sep 06 20:43:51 smsl-n100 volumio[960]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9)
Sep 06 20:43:51 smsl-n100 volumio[960]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 20:43:51 smsl-n100 ntpd[2534]: Soliciting pool server 193.106.93.116
Sep 06 20:43:52 smsl-n100 sudo[2545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-06 20:42
Sep 06 20:43:52 smsl-n100 sudo[2545]: 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"