-- Logs begin at Thu 2019-02-14 15:11:59 +05, end at Mon 2025-04-28 22:58:45 +05. -- Apr 28 22:57:31 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 22:57:31 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 22:57:31 smsl-n100 volumio[802]: info: Discovery: Getting this device information Apr 28 22:57:31 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioGetState Apr 28 22:57:31 smsl-n100 volumio[802]: info: CorePlayQueue::getTrack 3 Apr 28 22:57:31 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 22:57:31 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 22:57:31 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 22:57:31 smsl-n100 volumio[802]: info: Discovery: Getting this device information Apr 28 22:57:31 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioGetState Apr 28 22:57:31 smsl-n100 volumio[802]: info: CorePlayQueue::getTrack 3 Apr 28 22:57:31 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 22:57:32 smsl-n100 volumio[802]: verbose: New Socket.io Connection to 192.168.1.126:3000 from 192.168.1.89 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Apr 28 22:57:33 smsl-n100 volumio[802]: verbose: New Socket.io Connection to 192.168.1.126 from 192.168.1.89 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Apr 28 22:57:33 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioGetState Apr 28 22:57:33 smsl-n100 volumio[802]: info: CorePlayQueue::getTrack 3 Apr 28 22:57:33 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 28 22:57:33 smsl-n100 volumio[802]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 28 22:57:33 smsl-n100 volumio[802]: info: Listing playlists Apr 28 22:57:33 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 22:57:33 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 22:57:33 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioGetQueue Apr 28 22:57:33 smsl-n100 volumio[802]: info: CoreStateMachine::getQueue Apr 28 22:57:33 smsl-n100 volumio[802]: info: CorePlayQueue::getQueue Apr 28 22:57:36 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioSeek Apr 28 22:57:36 smsl-n100 volumio[802]: info: CoreStateMachine::seek Apr 28 22:57:36 smsl-n100 volumio[802]: info: CorePlayQueue::getTrack 3 Apr 28 22:57:36 smsl-n100 volumio[802]: info: TRACKBLOCK {"album":"Dynasty","albumUri":"qobuz://album/0060254706217","albumart":"https://static.qobuz.com/images/covers/17/62/0060254706217_600.jpg","artist":"Kiss","artistUri":"qobuz://artist/47440","audioQuality":"HI_RES","bitdepth":null,"duration":267,"explicit":false,"name":"Dirty Livin'","samplerate":null,"service":"qobuz","title":"Dirty Livin'","tracknumber":4,"type":"track","uri":"qobuz://song/20000879","volumeNumber":1,"tagImage":"/albumart?sectionimage=music_service/qobuz/icons/qobuzhires.png","channels":null} Apr 28 22:57:36 smsl-n100 volumio[802]: info: CoreStateMachine::startPlaybackTimer Apr 28 22:57:36 smsl-n100 volumio[802]: info: CorePlayQueue::getTrack 3 Apr 28 22:57:36 smsl-n100 volumio[802]: info: [1745863056450] ControllerQobuz::seek Apr 28 22:57:36 smsl-n100 volumio[802]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 28 22:57:36 smsl-n100 volumio[802]: info: ControllerMpd::seek Apr 28 22:57:36 smsl-n100 volumio[802]: info: CoreStateMachine::pushState Apr 28 22:57:36 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 22:57:36 smsl-n100 volumio[802]: STREAMING PROXY: Client dropped request, destroying Apr 28 22:57:36 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioPushState Apr 28 22:57:36 smsl-n100 volumio[802]: STREAMING PROXY: Handling url /?data=qobuz://song/20000879 Apr 28 22:57:36 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output update for this device Apr 28 22:57:36 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output Apr 28 22:57:36 smsl-n100 volumio[802]: info: Executing endpoint getStreamUrlqobuz Apr 28 22:57:36 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 28 22:57:37 smsl-n100 volumio[802]: info: getStreamUrl took 592 milliseconds Apr 28 22:57:37 smsl-n100 volumio[802]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=4101093&eid=20000879&fmt=27&profile=raw&app_id=539451548&cid=2727739&etsp=1745866656&hmac=eipihqoXm45_7DWYgZgHH_XCIBM Apr 28 22:57:37 smsl-n100 volumio[802]: STREAMING PROXY: Got range request: bytes=175765110- Apr 28 22:57:38 smsl-n100 volumio[802]: STREAMING PROXY: Response: 206, length: 14199160 Apr 28 22:57:38 smsl-n100 volumio[802]: STREAMING PROXY: Client dropped request, destroying Apr 28 22:57:38 smsl-n100 volumio[802]: STREAMING PROXY: Handling url /?data=qobuz://song/20000879 Apr 28 22:57:38 smsl-n100 volumio[802]: info: Executing endpoint getStreamUrlqobuz Apr 28 22:57:38 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 28 22:57:38 smsl-n100 volumio[802]: info: getStreamUrl took 495 milliseconds Apr 28 22:57:38 smsl-n100 volumio[802]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=4101093&eid=20000879&fmt=27&profile=raw&app_id=539451548&cid=2727739&etsp=1745866658&hmac=243oylawRyHJnO4ns5pRli-ETtw Apr 28 22:57:38 smsl-n100 volumio[802]: STREAMING PROXY: Got range request: bytes=175808271- Apr 28 22:57:38 smsl-n100 volumio[802]: STREAMING PROXY: Response: 206, length: 14155999 Apr 28 22:57:38 smsl-n100 volumio[802]: STREAMING PROXY: Client dropped request, destroying Apr 28 22:57:38 smsl-n100 volumio[802]: STREAMING PROXY: Handling url /?data=qobuz://song/20000879 Apr 28 22:57:38 smsl-n100 volumio[802]: info: Executing endpoint getStreamUrlqobuz Apr 28 22:57:38 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Apr 28 22:57:39 smsl-n100 volumio[802]: info: getStreamUrl took 464 milliseconds Apr 28 22:57:39 smsl-n100 volumio[802]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=4101093&eid=20000879&fmt=27&profile=raw&app_id=539451548&cid=2727739&etsp=1745866659&hmac=RBsWZ9hdZiaYrFJGjSbuEHKeYZs Apr 28 22:57:39 smsl-n100 volumio[802]: STREAMING PROXY: Got range request: bytes=175828768- Apr 28 22:57:39 smsl-n100 volumio[802]: STREAMING PROXY: Response: 206, length: 14135502 Apr 28 22:57:39 smsl-n100 volumio[802]: error: null Apr 28 22:57:39 smsl-n100 volumio[802]: Upnp client error: Error: This socket has been ended by the other party Apr 28 22:57:39 smsl-n100 volumio[802]: info: Apr 28 22:57:39 smsl-n100 volumio[802]: ---------------------------- MPD announces state update: player Apr 28 22:57:39 smsl-n100 volumio[802]: info: ControllerMpd::getState Apr 28 22:57:39 smsl-n100 volumio[802]: verbose: ControllerMpd::sendMpdCommand status Apr 28 22:57:39 smsl-n100 volumio[802]: info: sendMpdCommand status took 8 milliseconds Apr 28 22:57:39 smsl-n100 volumio[802]: verbose: ControllerMpd::parseState Apr 28 22:57:39 smsl-n100 volumio[802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 22:57:39 smsl-n100 volumio[802]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 28 22:57:39 smsl-n100 volumio[802]: verbose: ControllerMpd::parseTrackInfo Apr 28 22:57:39 smsl-n100 volumio[802]: info: ControllerMpd::pushState Apr 28 22:57:39 smsl-n100 volumio[802]: info: CoreCommandRouter::servicePushState Apr 28 22:57:39 smsl-n100 volumio[802]: info: CorePlayQueue::getTrack 3 Apr 28 22:57:39 smsl-n100 volumio[802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":243000,"duration":267,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5665 Kbps","isStreaming":false,"title":"20000879","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/20000879","trackType":"qobuz"} Apr 28 22:57:39 smsl-n100 volumio[802]: verbose: CURRENT POSITION 3 Apr 28 22:57:39 smsl-n100 volumio[802]: info: CoreStateMachine::syncState stateService play Apr 28 22:57:39 smsl-n100 volumio[802]: info: CoreStateMachine::syncState currentStatus play Apr 28 22:57:39 smsl-n100 volumio[802]: info: Received an update from plugin. extracting info from payload Apr 28 22:57:39 smsl-n100 volumio[802]: info: CoreStateMachine::pushState Apr 28 22:57:39 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 22:57:39 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioPushState Apr 28 22:57:39 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output update for this device Apr 28 22:57:39 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output Apr 28 22:57:39 smsl-n100 volumio[802]: info: CoreStateMachine::pushState Apr 28 22:57:39 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioPushState Apr 28 22:57:39 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output update for this device Apr 28 22:57:39 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output Apr 28 22:57:39 smsl-n100 volumio[802]: info: ------------------------------ 139ms Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioPause Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreStateMachine::pause Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreStateMachine::stPlaybackTimer Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreStateMachine::servicePause Apr 28 22:57:41 smsl-n100 volumio[802]: info: CorePlayQueue::getTrack 3 Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreCommandRouter::servicePause Apr 28 22:57:41 smsl-n100 volumio[802]: info: [1745863061599] ControllerQobuz::pause Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 28 22:57:41 smsl-n100 volumio[802]: info: ControllerMpd::pause Apr 28 22:57:41 smsl-n100 volumio[802]: verbose: ControllerMpd::sendMpdCommand pause Apr 28 22:57:41 smsl-n100 volumio[802]: info: Apr 28 22:57:41 smsl-n100 volumio[802]: ---------------------------- MPD announces state update: player Apr 28 22:57:41 smsl-n100 volumio[802]: info: sendMpdCommand pause took 5 milliseconds Apr 28 22:57:41 smsl-n100 volumio[802]: info: ControllerMpd::getState Apr 28 22:57:41 smsl-n100 volumio[802]: verbose: ControllerMpd::sendMpdCommand status Apr 28 22:57:41 smsl-n100 volumio[802]: info: sendMpdCommand status took 2 milliseconds Apr 28 22:57:41 smsl-n100 volumio[802]: verbose: ControllerMpd::parseState Apr 28 22:57:41 smsl-n100 volumio[802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 22:57:41 smsl-n100 volumio[802]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 28 22:57:41 smsl-n100 volumio[802]: verbose: ControllerMpd::parseTrackInfo Apr 28 22:57:41 smsl-n100 volumio[802]: info: ControllerMpd::pushState Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreCommandRouter::servicePushState Apr 28 22:57:41 smsl-n100 volumio[802]: info: CorePlayQueue::getTrack 3 Apr 28 22:57:41 smsl-n100 volumio[802]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":246152,"duration":267,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5465 Kbps","isStreaming":false,"title":"20000879","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/20000879","trackType":"qobuz"} Apr 28 22:57:41 smsl-n100 volumio[802]: verbose: CURRENT POSITION 3 Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreStateMachine::syncState stateService pause Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreStateMachine::syncState currentStatus pause Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreStateMachine::pushState Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioPushState Apr 28 22:57:41 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output update for this device Apr 28 22:57:41 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreStateMachine::stPlaybackTimer Apr 28 22:57:41 smsl-n100 volumio[802]: info: ------------------------------ 48ms Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreStateMachine::pushState Apr 28 22:57:41 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioPushState Apr 28 22:57:41 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output update for this device Apr 28 22:57:41 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output Apr 28 22:57:41 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: 100, message: undefined Apr 28 22:57:41 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 28 22:57:41 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: 100, message: undefined Apr 28 22:57:41 smsl-n100 volumio[802]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 28 22:57:59 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 22:57:59 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 22:57:59 smsl-n100 volumio[802]: info: Discovery: Getting this device information Apr 28 22:57:59 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioGetState Apr 28 22:57:59 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 22:58:33 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Down Apr 28 22:58:33 smsl-n100 dhcpcd[598]: eth0: carrier lost Apr 28 22:58:33 smsl-n100 dhcpcd[911]: eth0: carrier lost Apr 28 22:58:33 smsl-n100 avahi-daemon[526]: Withdrawing address record for 192.168.1.126 on eth0. Apr 28 22:58:33 smsl-n100 avahi-daemon[526]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.126. Apr 28 22:58:33 smsl-n100 avahi-daemon[526]: Interface eth0.IPv4 no longer relevant for mDNS. Apr 28 22:58:33 smsl-n100 dhcpcd[598]: eth0: deleting route to 192.168.1.0/24 Apr 28 22:58:33 smsl-n100 dhcpcd[598]: eth0: deleting default route via 192.168.1.1 Apr 28 22:58:33 smsl-n100 dhcpcd[911]: eth0: deleting route to 192.168.1.0/24 Apr 28 22:58:33 smsl-n100 dhcpcd[911]: eth0: deleting default route via 192.168.1.1 Apr 28 22:58:33 smsl-n100 volumio[802]: info: Discovery: A device disappeared from network Apr 28 22:58:33 smsl-n100 ifplugd(eth0)[757]: Link beat lost. Apr 28 22:58:35 smsl-n100 ntpd[910]: Deleting interface #3 eth0, 192.168.1.126#123, interface stats: received=365, sent=373, dropped=0, active_time=6856 secs Apr 28 22:58:35 smsl-n100 ntpd[910]: 94.141.168.72 local addr 192.168.1.126 -> Apr 28 22:58:35 smsl-n100 ntpd[910]: 92.255.126.3 local addr 192.168.1.126 -> Apr 28 22:58:35 smsl-n100 ntpd[910]: 92.241.18.100 local addr 192.168.1.126 -> Apr 28 22:58:35 smsl-n100 ntpd[910]: 89.109.251.26 local addr 192.168.1.126 -> Apr 28 22:58:35 smsl-n100 ntpd[910]: 51.250.35.68 local addr 192.168.1.126 -> Apr 28 22:58:35 smsl-n100 ntpd[910]: 89.179.240.219 local addr 192.168.1.126 -> Apr 28 22:58:36 smsl-n100 volumio[802]: info: Reporting MCU Network Status: 0 Apr 28 22:58:36 smsl-n100 volumio[802]: info: Volumio Network Manager: Network status updated: 0 Apr 28 22:58:36 smsl-n100 volumio[802]: info: CoreStateMachine::pushState Apr 28 22:58:36 smsl-n100 volumio[802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 22:58:36 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioPushState Apr 28 22:58:36 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output update for this device Apr 28 22:58:36 smsl-n100 volumio[802]: info: MRS: Pushing multiroomSync output Apr 28 22:58:36 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: 100, message: undefined Apr 28 22:58:36 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 28 22:58:36 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: 100, message: undefined Apr 28 22:58:36 smsl-n100 volumio[802]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 28 22:58:36 smsl-n100 volumio[802]: error: Serial API: Failed to decode command: 0, message: undefined Apr 28 22:58:38 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx Apr 28 22:58:38 smsl-n100 dhcpcd[598]: eth0: carrier acquired Apr 28 22:58:38 smsl-n100 dhcpcd[911]: eth0: carrier acquired Apr 28 22:58:38 smsl-n100 dhcpcd[911]: eth0: IAID f8:33:b7:4d Apr 28 22:58:38 smsl-n100 dhcpcd[598]: eth0: IAID f8:33:b7:4d Apr 28 22:58:39 smsl-n100 dhcpcd[911]: eth0: rebinding lease of 192.168.1.126 Apr 28 22:58:39 smsl-n100 dhcpcd[911]: eth0: probing address 192.168.1.126/24 Apr 28 22:58:39 smsl-n100 ifplugd(eth0)[757]: Link beat detected. Apr 28 22:58:39 smsl-n100 dhcpcd[598]: eth0: soliciting an IPv6 router Apr 28 22:58:39 smsl-n100 dhcpcd[598]: eth0: rebinding lease of 192.168.1.126 Apr 28 22:58:39 smsl-n100 dhcpcd[598]: eth0: probing address 192.168.1.126/24 Apr 28 22:58:39 smsl-n100 dhcpcd[911]: eth0: soliciting an IPv6 router Apr 28 22:58:43 smsl-n100 dhcpcd[598]: eth0: leased 192.168.1.126 for 86400 seconds Apr 28 22:58:43 smsl-n100 avahi-daemon[526]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.126. Apr 28 22:58:43 smsl-n100 dhcpcd[598]: eth0: adding route to 192.168.1.0/24 Apr 28 22:58:43 smsl-n100 avahi-daemon[526]: New relevant interface eth0.IPv4 for mDNS. Apr 28 22:58:43 smsl-n100 dhcpcd[598]: eth0: adding default route via 192.168.1.1 Apr 28 22:58:43 smsl-n100 avahi-daemon[526]: Registering new address record for 192.168.1.126 on eth0.IPv4. Apr 28 22:58:44 smsl-n100 ntpd[910]: ntpd exiting on signal 15 (Terminated) Apr 28 22:58:44 smsl-n100 systemd[1]: Stopping Network Time Service... Apr 28 22:58:44 smsl-n100 systemd[1]: ntp.service: Succeeded. Apr 28 22:58:44 smsl-n100 systemd[1]: Stopped Network Time Service. Apr 28 22:58:44 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 28 22:58:44 smsl-n100 systemd[1]: Starting Network Time Service... Apr 28 22:58:44 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 28 22:58:44 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 28 22:58:44 smsl-n100 ntpd[30987]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 28 22:58:44 smsl-n100 ntpd[30987]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 28 22:58:44 smsl-n100 systemd[1]: Started Network Time Service. Apr 28 22:58:44 smsl-n100 ntpd[30995]: proto: precision = 1.166 usec (-20) Apr 28 22:58:44 smsl-n100 ntpd[30995]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 28 22:58:44 smsl-n100 ntpd[30995]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 28 22:58:44 smsl-n100 ntpd[30995]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 853 days ago Apr 28 22:58:44 smsl-n100 dhcpcd[911]: eth0: leased 192.168.1.126 for 86400 seconds Apr 28 22:58:44 smsl-n100 ntpd[30995]: Listen and drop on 0 v6wildcard [::]:123 Apr 28 22:58:44 smsl-n100 ntpd[30995]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 28 22:58:44 smsl-n100 dhcpcd[911]: eth0: adding route to 192.168.1.0/24 Apr 28 22:58:44 smsl-n100 dhcpcd[911]: eth0: adding default route via 192.168.1.1 Apr 28 22:58:44 smsl-n100 ntpd[30995]: Listen normally on 2 lo 127.0.0.1:123 Apr 28 22:58:44 smsl-n100 ntpd[30995]: Listen normally on 3 eth0 192.168.1.126:123 Apr 28 22:58:44 smsl-n100 ntpd[30995]: Listening on routing socket on fd #20 for interface updates Apr 28 22:58:44 smsl-n100 ntpd[30995]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 28 22:58:44 smsl-n100 ntpd[30995]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 28 22:58:44 smsl-n100 ntpd[30995]: ntpd exiting on signal 15 (Terminated) Apr 28 22:58:44 smsl-n100 systemd[1]: Stopping Network Time Service... Apr 28 22:58:44 smsl-n100 systemd[1]: ntp.service: Succeeded. Apr 28 22:58:44 smsl-n100 systemd[1]: Stopped Network Time Service. Apr 28 22:58:44 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 28 22:58:44 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 28 22:58:44 smsl-n100 systemd[1]: Starting Network Time Service... Apr 28 22:58:44 smsl-n100 volumio[802]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 28 22:58:44 smsl-n100 ntpd[31031]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 28 22:58:44 smsl-n100 ntpd[31031]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 28 22:58:44 smsl-n100 systemd[1]: Started Network Time Service. Apr 28 22:58:44 smsl-n100 ntpd[31039]: proto: precision = 1.166 usec (-20) Apr 28 22:58:44 smsl-n100 ntpd[31039]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 28 22:58:44 smsl-n100 ntpd[31039]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 28 22:58:44 smsl-n100 ntpd[31039]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 853 days ago Apr 28 22:58:44 smsl-n100 ntpd[31039]: Listen and drop on 0 v6wildcard [::]:123 Apr 28 22:58:44 smsl-n100 ntpd[31039]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 28 22:58:44 smsl-n100 ntpd[31039]: Listen normally on 2 lo 127.0.0.1:123 Apr 28 22:58:44 smsl-n100 ntpd[31039]: Listen normally on 3 eth0 192.168.1.126:123 Apr 28 22:58:44 smsl-n100 ntpd[31039]: Listening on routing socket on fd #20 for interface updates Apr 28 22:58:44 smsl-n100 ntpd[31039]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 28 22:58:44 smsl-n100 ntpd[31039]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 28 22:58:44 smsl-n100 volumio[802]: info: Discovery: adding bd56b18b-f634-44ea-85d0-527c7d649f4b Apr 28 22:58:44 smsl-n100 volumio[802]: info: Discovery: Found device SMSL N100 Apr 28 22:58:44 smsl-n100 volumio[802]: info: CoreCommandRouter::volumioGetState Apr 28 22:58:44 smsl-n100 volumio[802]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 22:58:44 smsl-n100 volumio[802]: Error: The value NaN is not a number Apr 28 22:58:44 smsl-n100 volumio[802]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Apr 28 22:58:44 smsl-n100 volumio[802]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Apr 28 22:58:44 smsl-n100 volumio[802]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Apr 28 22:58:44 smsl-n100 volumio[802]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Apr 28 22:58:44 smsl-n100 volumio[802]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Apr 28 22:58:44 smsl-n100 volumio[802]: at Browser.emit (events.js:400:28) Apr 28 22:58:44 smsl-n100 volumio[802]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Apr 28 22:58:44 smsl-n100 volumio[802]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Apr 28 22:58:44 smsl-n100 volumio[802]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Apr 28 22:58:44 smsl-n100 volumio[802]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Apr 28 22:58:44 smsl-n100 volumio[802]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Apr 28 22:58:44 smsl-n100 volumio[802]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Apr 28 22:58:44 smsl-n100 volumio[802]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Apr 28 22:58:44 smsl-n100 volumio[802]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 22:58:45 smsl-n100 ntpd[31039]: Soliciting pool server 217.170.87.229 Apr 28 22:58:45 smsl-n100 sudo[31050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-28 22:57 Apr 28 22:58:45 smsl-n100 sudo[31050]: 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"