-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Sat 2025-09-13 09:58:49 UTC. --
Sep 13 09:58:22 volumio-khadas dhcpcd[5364]: eth0: carrier acquired
Sep 13 09:58:22 volumio-khadas kernel: meson6-dwmac c9410000.ethernet eth0: Link is Up - 100Mbps/Full - flow control off
Sep 13 09:58:22 volumio-khadas dhcpcd[5364]: eth0: IAID 63:55:ba:26
Sep 13 09:58:23 volumio-khadas dhcpcd[5364]: eth0: soliciting an IPv6 router
Sep 13 09:58:23 volumio-khadas ifplugd(eth0)[5030]: Link beat detected.
Sep 13 09:58:23 volumio-khadas ifplugd(eth0)[5030]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Sep 13 09:58:23 volumio-khadas ifplugd(eth0)[5030]: client: sending commands to master dhcpcd process
Sep 13 09:58:23 volumio-khadas dhcpcd[6636]: sending commands to master dhcpcd process
Sep 13 09:58:23 volumio-khadas dhcpcd[5364]: control command: /sbin/dhcpcd eth0
Sep 13 09:58:23 volumio-khadas dhcpcd[5364]: eth0: soliciting a DHCP lease
Sep 13 09:58:23 volumio-khadas ifplugd(eth0)[5030]: Program executed successfully.
Sep 13 09:58:23 volumio-khadas dhcpcd[5364]: eth0: offered 192.168.5.171 from 192.168.5.1
Sep 13 09:58:23 volumio-khadas dhcpcd[5364]: eth0: probing address 192.168.5.171/24
Sep 13 09:58:28 volumio-khadas dhcpcd[5364]: eth0: leased 192.168.5.171 for 3600 seconds
Sep 13 09:58:28 volumio-khadas avahi-daemon[4472]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.5.171.
Sep 13 09:58:28 volumio-khadas avahi-daemon[4472]: New relevant interface eth0.IPv4 for mDNS.
Sep 13 09:58:28 volumio-khadas avahi-daemon[4472]: Registering new address record for 192.168.5.171 on eth0.IPv4.
Sep 13 09:58:28 volumio-khadas dhcpcd[5364]: eth0: adding route to 192.168.5.0/24
Sep 13 09:58:28 volumio-khadas dhcpcd[5364]: eth0: adding default route via 192.168.5.1
Sep 13 09:58:28 volumio-khadas ntpd[5363]: ntpd exiting on signal 15 (Terminated)
Sep 13 09:58:28 volumio-khadas systemd[1]: Stopping Network Time Service...
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 217.175.196.134 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 131.130.251.107 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 152.53.119.76 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 152.53.44.250 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 178.251.64.52 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 217.196.145.42 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 46.102.157.67 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 152.53.15.127 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 83.215.130.11 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 151.236.30.71 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 91.206.8.34 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 152.53.132.244 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 162.159.200.1 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 83.137.41.10 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 91.206.8.36 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 94.199.174.89 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 86.59.113.124 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas ntpd[5363]: 146.255.56.84 local addr 192.168.5.199 ->
Sep 13 09:58:28 volumio-khadas systemd[1]: ntp.service: Succeeded.
Sep 13 09:58:28 volumio-khadas systemd[1]: Stopped Network Time Service.
Sep 13 09:58:28 volumio-khadas systemd[1]: Starting Network Time Service...
Sep 13 09:58:29 volumio-khadas ntpd[6700]: ntpd 4.2.8p12@1.3728-o (1): Starting
Sep 13 09:58:29 volumio-khadas ntpd[6700]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Sep 13 09:58:29 volumio-khadas systemd[1]: Started Network Time Service.
Sep 13 09:58:29 volumio-khadas ntpd[6732]: proto: precision = 1.208 usec (-20)
Sep 13 09:58:29 volumio-khadas ntpd[6732]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Sep 13 09:58:29 volumio-khadas ntpd[6732]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Sep 13 09:58:29 volumio-khadas ntpd[6732]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1174 days ago
Sep 13 09:58:29 volumio-khadas ntpd[6732]: Listen and drop on 0 v6wildcard [::]:123
Sep 13 09:58:29 volumio-khadas ntpd[6732]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Sep 13 09:58:29 volumio-khadas ntpd[6732]: Listen normally on 2 lo 127.0.0.1:123
Sep 13 09:58:29 volumio-khadas ntpd[6732]: Listen normally on 3 eth0 192.168.5.171:123
Sep 13 09:58:29 volumio-khadas ntpd[6732]: Listen normally on 4 wlan0 192.168.5.199:123
Sep 13 09:58:29 volumio-khadas ntpd[6732]: Listening on routing socket on fd #21 for interface updates
Sep 13 09:58:29 volumio-khadas ntpd[6732]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized
Sep 13 09:58:29 volumio-khadas ntpd[6732]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized
Sep 13 09:58:30 volumio-khadas ntpd[6732]: Soliciting pool server 162.159.200.123
Sep 13 09:58:31 volumio-khadas ntpd[6732]: Soliciting pool server 152.53.132.244
Sep 13 09:58:31 volumio-khadas ntpd[6732]: Soliciting pool server 217.196.145.42
Sep 13 09:58:32 volumio-khadas ntpd[6732]: Soliciting pool server 162.159.200.1
Sep 13 09:58:32 volumio-khadas ntpd[6732]: Soliciting pool server 78.41.116.149
Sep 13 09:58:32 volumio-khadas ntpd[6732]: Soliciting pool server 185.144.161.170
Sep 13 09:58:33 volumio-khadas ntpd[6732]: Soliciting pool server 152.53.44.250
Sep 13 09:58:33 volumio-khadas ntpd[6732]: Soliciting pool server 83.216.46.6
Sep 13 09:58:33 volumio-khadas ntpd[6732]: Soliciting pool server 83.137.41.14
Sep 13 09:58:33 volumio-khadas ntpd[6732]: Soliciting pool server 152.53.44.250
Sep 13 09:58:34 volumio-khadas ntpd[6732]: Soliciting pool server 178.251.64.52
Sep 13 09:58:34 volumio-khadas ntpd[6732]: Soliciting pool server 91.206.8.34
Sep 13 09:58:35 volumio-khadas ntpd[6732]: Soliciting pool server 91.206.8.36
Sep 13 09:58:36 volumio-khadas ntpd[6732]: Soliciting pool server 2001:858:2:4:887d:c7ff:fef8:d02d
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: Discovery: this is already registered, 8fd95c9d-85fd-4c5c-b1f8-9db7f25ab78d
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: mDNS: Found device Volumio KHADAS
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: CoreCommandRouter::volumioGetState
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: CorePlayQueue::getTrack 0
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: MRS: Pushing multiroomSync output for this device
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: MRS: Pushing multiroomSync output
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: Adding audio output:
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: Discovery: this is already registered, 59c0ab9e-c208-4cca-a273-ee70af86bdeb
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: mDNS: Found device Volumio HD
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: MRS: Pushing audio output on request
Sep 13 09:58:37 volumio-khadas volumio[5377]: info: MRS: Pushing multiroomSync output
Sep 13 09:58:38 volumio-khadas ntpd[6732]: receive: Unexpected origin timestamp 0xec6fbece.072ff06e does not match aorg 0000000000.00000000 from server@152.53.44.250 xmt 0xec6fbece.2cfde696
Sep 13 09:58:38 volumio-khadas ntpd[6732]: receive: Unexpected origin timestamp 0xec6fbece.0728c4f9 does not match aorg 0000000000.00000000 from server@91.206.8.34 xmt 0xec6fbece.2c806069
Sep 13 09:58:38 volumio-khadas ntpd[6732]: receive: Unexpected origin timestamp 0xec6fbece.072da9a8 does not match aorg 0000000000.00000000 from server@83.216.46.6 xmt 0xec6fbece.2ca4ea0e
Sep 13 09:58:38 volumio-khadas ntpd[6732]: receive: Unexpected origin timestamp 0xec6fbece.0735654f does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xec6fbece.2c402f2e
Sep 13 09:58:38 volumio-khadas ntpd[6732]: receive: Unexpected origin timestamp 0xec6fbece.0733ae72 does not match aorg 0000000000.00000000 from server@78.41.116.149 xmt 0xec6fbece.2c957330
Sep 13 09:58:38 volumio-khadas ntpd[6732]: receive: Unexpected origin timestamp 0xec6fbece.0731da1f does not match aorg 0000000000.00000000 from server@185.144.161.170 xmt 0xec6fbece.2c93495c
Sep 13 09:58:38 volumio-khadas ntpd[6732]: receive: Unexpected origin timestamp 0xec6fbece.073724a9 does not match aorg 0000000000.00000000 from server@152.53.132.244 xmt 0xec6fbece.2db03072
Sep 13 09:58:38 volumio-khadas ntpd[6732]: receive: Unexpected origin timestamp 0xec6fbece.072b9ea9 does not match aorg 0000000000.00000000 from server@83.137.41.14 xmt 0xec6fbece.2dc17174
Sep 13 09:58:45 volumio-khadas volumio[5377]: verbose: New Socket.io Connection to 192.168.5.199:3000 from 192.168.5.129 UA: node-XMLHttpRequest Total Clients: 4
Sep 13 09:58:45 volumio-khadas volumio[5377]: verbose: New Socket.io Connection to 192.168.5.199 from 192.168.5.94 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Total Clients: 5
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: MRS: Adding multiroomSync output
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: Adding audio output:
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: MRS: Pushing multiroomSync output
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CoreCommandRouter::volumioGetState
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CorePlayQueue::getTrack 0
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CoreCommandRouter::volumioGetState
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CorePlayQueue::getTrack 0
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CoreCommandRouter::volumioGetState
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CorePlayQueue::getTrack 0
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CoreCommandRouter::volumioGetState
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CorePlayQueue::getTrack 0
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CoreCommandRouter::volumioGetState
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CorePlayQueue::getTrack 0
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: Listing playlists
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: MRS: Updating multiroomSync output
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CoreCommandRouter::volumioGetState
Sep 13 09:58:45 volumio-khadas volumio[5377]: info: CorePlayQueue::getTrack 0
Sep 13 09:58:48 volumio-khadas volumio[5377]: info: CorePlayQueue::getTrack 0
Sep 13 09:58:48 volumio-khadas volumio[5377]: info: CorePlayQueue::getTrack 1
Sep 13 09:58:48 volumio-khadas volumio[5377]: info: Prefetching next song
Sep 13 09:58:48 volumio-khadas volumio[5377]: info: [1757757528479] ControllerTidal::prefetch
Sep 13 09:58:48 volumio-khadas volumio[5377]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 13 09:58:48 volumio-khadas volumio[5377]: TypeError: Cannot read property 'highestSoundQuality' of undefined
Sep 13 09:58:48 volumio-khadas volumio[5377]: at ControllerTidal.getProperSoundQuality (/myvolumio/plugins/music_service/tidal/tidal_real:1:17751)
Sep 13 09:58:48 volumio-khadas volumio[5377]: at ControllerTidal.prefetch (/myvolumio/plugins/music_service/tidal/tidal_real:1:18455)
Sep 13 09:58:48 volumio-khadas volumio[5377]: at CoreStateMachine.increasePlaybackTimer (/volumio/app/statemachine.js:437:18)
Sep 13 09:58:48 volumio-khadas volumio[5377]: at listOnTimeout (internal/timers.js:557:17)
Sep 13 09:58:48 volumio-khadas volumio[5377]: at processTimers (internal/timers.js:500:7)
Sep 13 09:58:48 volumio-khadas volumio[5377]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 13 09:58:49 volumio-khadas sudo[6765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-13 09:57
Sep 13 09:58:49 volumio-khadas sudo[6765]: 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="613d705c083fd29de3027cf6e63a923a6020da8e"
VOLUMIO_FE_VERSION="575f38b17bfc836dbd47f560a440d36ecd98d5af"
VOLUMIO_FE3_VERSION="af818e7eb038d49989134ddd7bf2b2ffaa8cf083"
VOLUMIO_BE_VERSION="5936439c04ed803864b9ef314729c659b841752e"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 29 Jan 2022 12:36:00 AM CET"
VOLUMIO_VERSION="3.212"
VOLUMIO_HARDWARE="kvim1"
VOLUMIO_DEVICENAME="Khadas VIM1"
VOLUMIO_HASH="a41712c8cd708e7cae9978278a240084"