-- Logs begin at Sat 2024-08-24 13:53:23 AEST, end at Fri 2024-09-06 07:59:07 AEST. -- Sep 06 07:58:07 minidsp-shd dhcpcd[718]: eth0: carrier lost Sep 06 07:58:07 minidsp-shd dhcpcd[526]: eth0: carrier lost Sep 06 07:58:07 minidsp-shd kernel: dwmac-sun8i 1c30000.ethernet eth0: Link is Down Sep 06 07:58:07 minidsp-shd avahi-daemon[435]: Withdrawing address record for 10.1.1.194 on eth0. Sep 06 07:58:07 minidsp-shd avahi-daemon[435]: Leaving mDNS multicast group on interface eth0.IPv4 with address 10.1.1.194. Sep 06 07:58:07 minidsp-shd avahi-daemon[435]: Interface eth0.IPv4 no longer relevant for mDNS. Sep 06 07:58:07 minidsp-shd volumio[654]: info: Discovery: A device disappeared from network Sep 06 07:58:07 minidsp-shd dhcpcd[718]: eth0: deleting route to 10.1.1.0/24 Sep 06 07:58:07 minidsp-shd dhcpcd[718]: eth0: deleting default route via 10.1.1.1 Sep 06 07:58:07 minidsp-shd dhcpcd[526]: eth0: deleting route to 10.1.1.0/24 Sep 06 07:58:07 minidsp-shd dhcpcd[526]: eth0: deleting default route via 10.1.1.1 Sep 06 07:58:07 minidsp-shd ifplugd(eth0)[624]: Link beat lost. Sep 06 07:58:09 minidsp-shd ntpd[10246]: Deleting interface #3 eth0, 10.1.1.194#123, interface stats: received=1032, sent=1034, dropped=0, active_time=27693 secs Sep 06 07:58:09 minidsp-shd ntpd[10246]: 159.196.44.158 local addr 10.1.1.194 -> Sep 06 07:58:09 minidsp-shd ntpd[10246]: 162.159.200.1 local addr 10.1.1.194 -> Sep 06 07:58:09 minidsp-shd ntpd[10246]: 110.232.114.22 local addr 10.1.1.194 -> Sep 06 07:58:09 minidsp-shd ntpd[10246]: 27.124.125.251 local addr 10.1.1.194 -> Sep 06 07:58:09 minidsp-shd ntpd[10246]: 162.159.200.123 local addr 10.1.1.194 -> Sep 06 07:58:09 minidsp-shd ntpd[10246]: 119.18.6.37 local addr 10.1.1.194 -> Sep 06 07:58:14 minidsp-shd dhcpcd[526]: eth0: carrier acquired Sep 06 07:58:14 minidsp-shd kernel: dwmac-sun8i 1c30000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Sep 06 07:58:14 minidsp-shd dhcpcd[718]: eth0: carrier acquired Sep 06 07:58:14 minidsp-shd dhcpcd[718]: eth0: IAID d4:3c:6e:3a Sep 06 07:58:14 minidsp-shd dhcpcd[526]: eth0: IAID d4:3c:6e:3a Sep 06 07:58:14 minidsp-shd dhcpcd[718]: eth0: soliciting an IPv6 router Sep 06 07:58:14 minidsp-shd ifplugd(eth0)[624]: Link beat detected. Sep 06 07:58:15 minidsp-shd dhcpcd[718]: eth0: rebinding lease of 10.1.1.194 Sep 06 07:58:15 minidsp-shd dhcpcd[526]: eth0: rebinding lease of 10.1.1.194 Sep 06 07:58:15 minidsp-shd dhcpcd[526]: eth0: soliciting an IPv6 router Sep 06 07:58:18 minidsp-shd dhcpcd[718]: eth0: probing address 10.1.1.194/24 Sep 06 07:58:19 minidsp-shd dhcpcd[526]: eth0: probing address 10.1.1.194/24 Sep 06 07:58:23 minidsp-shd dhcpcd[718]: eth0: leased 10.1.1.194 for 86400 seconds Sep 06 07:58:23 minidsp-shd dhcpcd[718]: eth0: adding route to 10.1.1.0/24 Sep 06 07:58:23 minidsp-shd avahi-daemon[435]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.1.1.194. Sep 06 07:58:23 minidsp-shd dhcpcd[718]: eth0: adding default route via 10.1.1.1 Sep 06 07:58:23 minidsp-shd avahi-daemon[435]: New relevant interface eth0.IPv4 for mDNS. Sep 06 07:58:23 minidsp-shd avahi-daemon[435]: Registering new address record for 10.1.1.194 on eth0.IPv4. Sep 06 07:58:23 minidsp-shd ntpd[10246]: ntpd exiting on signal 15 (Terminated) Sep 06 07:58:23 minidsp-shd systemd[1]: Stopping Network Time Service... Sep 06 07:58:23 minidsp-shd volumio[654]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 06 07:58:23 minidsp-shd systemd[1]: ntp.service: Succeeded. Sep 06 07:58:23 minidsp-shd systemd[1]: Stopped Network Time Service. Sep 06 07:58:23 minidsp-shd volumio[654]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 06 07:58:23 minidsp-shd systemd[1]: Starting Network Time Service... Sep 06 07:58:23 minidsp-shd volumio[654]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 06 07:58:23 minidsp-shd ntpd[29698]: ntpd 4.2.8p12@1.3728-o (1): Starting Sep 06 07:58:23 minidsp-shd ntpd[29698]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Sep 06 07:58:23 minidsp-shd systemd[1]: Started Network Time Service. Sep 06 07:58:23 minidsp-shd ntpd[29705]: proto: precision = 1.167 usec (-20) Sep 06 07:58:23 minidsp-shd ntpd[29705]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Sep 06 07:58:23 minidsp-shd ntpd[29705]: 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 07:58:23 minidsp-shd ntpd[29705]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 618 days ago Sep 06 07:58:23 minidsp-shd ntpd[29705]: Listen and drop on 0 v6wildcard [::]:123 Sep 06 07:58:23 minidsp-shd ntpd[29705]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 06 07:58:23 minidsp-shd ntpd[29705]: Listen normally on 2 lo 127.0.0.1:123 Sep 06 07:58:23 minidsp-shd ntpd[29705]: Listen normally on 3 eth0 10.1.1.194:123 Sep 06 07:58:23 minidsp-shd ntpd[29705]: Listening on routing socket on fd #20 for interface updates Sep 06 07:58:23 minidsp-shd ntpd[29705]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Sep 06 07:58:23 minidsp-shd ntpd[29705]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Sep 06 07:58:24 minidsp-shd volumio[654]: info: Discovery: adding b6faea1e-01a2-48ce-8be3-6bd2d90f236d Sep 06 07:58:24 minidsp-shd volumio[654]: info: Discovery: Found device miniDSP SHD Sep 06 07:58:24 minidsp-shd volumio[654]: info: CoreCommandRouter::volumioGetState Sep 06 07:58:24 minidsp-shd ntpd[29705]: Soliciting pool server 27.124.125.251 Sep 06 07:58:25 minidsp-shd dhcpcd[526]: eth0: leased 10.1.1.194 for 86400 seconds Sep 06 07:58:25 minidsp-shd dhcpcd[526]: eth0: adding route to 10.1.1.0/24 Sep 06 07:58:25 minidsp-shd dhcpcd[526]: eth0: adding default route via 10.1.1.1 Sep 06 07:58:25 minidsp-shd ntpd[29705]: Soliciting pool server 103.152.64.212 Sep 06 07:58:25 minidsp-shd ntpd[29705]: Soliciting pool server 119.18.6.37 Sep 06 07:58:25 minidsp-shd ntpd[29705]: ntpd exiting on signal 15 (Terminated) Sep 06 07:58:25 minidsp-shd ntpd[29705]: 27.124.125.251 local addr 10.1.1.194 -> Sep 06 07:58:25 minidsp-shd systemd[1]: Stopping Network Time Service... Sep 06 07:58:25 minidsp-shd ntpd[29705]: 103.152.64.212 local addr 10.1.1.194 -> Sep 06 07:58:25 minidsp-shd ntpd[29705]: 119.18.6.37 local addr 10.1.1.194 -> Sep 06 07:58:25 minidsp-shd volumio[654]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 06 07:58:25 minidsp-shd systemd[1]: ntp.service: Succeeded. Sep 06 07:58:25 minidsp-shd systemd[1]: Stopped Network Time Service. Sep 06 07:58:25 minidsp-shd volumio[654]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 06 07:58:25 minidsp-shd systemd[1]: Starting Network Time Service... Sep 06 07:58:25 minidsp-shd volumio[654]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 06 07:58:25 minidsp-shd ntpd[29739]: ntpd 4.2.8p12@1.3728-o (1): Starting Sep 06 07:58:25 minidsp-shd ntpd[29739]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Sep 06 07:58:25 minidsp-shd systemd[1]: Started Network Time Service. Sep 06 07:58:25 minidsp-shd ntpd[29745]: proto: precision = 1.250 usec (-20) Sep 06 07:58:25 minidsp-shd ntpd[29745]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Sep 06 07:58:25 minidsp-shd ntpd[29745]: 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 07:58:25 minidsp-shd ntpd[29745]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 618 days ago Sep 06 07:58:25 minidsp-shd ntpd[29745]: Listen and drop on 0 v6wildcard [::]:123 Sep 06 07:58:25 minidsp-shd ntpd[29745]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 06 07:58:25 minidsp-shd ntpd[29745]: Listen normally on 2 lo 127.0.0.1:123 Sep 06 07:58:25 minidsp-shd ntpd[29745]: Listen normally on 3 eth0 10.1.1.194:123 Sep 06 07:58:25 minidsp-shd ntpd[29745]: Listening on routing socket on fd #20 for interface updates Sep 06 07:58:25 minidsp-shd ntpd[29745]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Sep 06 07:58:25 minidsp-shd ntpd[29745]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Sep 06 07:58:26 minidsp-shd ntpd[29745]: Soliciting pool server 27.124.125.251 Sep 06 07:58:27 minidsp-shd ntpd[29745]: Soliciting pool server 67.219.100.202 Sep 06 07:58:27 minidsp-shd ntpd[29745]: Soliciting pool server 119.18.6.37 Sep 06 07:58:28 minidsp-shd ntpd[29745]: Soliciting pool server 162.159.200.1 Sep 06 07:58:28 minidsp-shd ntpd[29745]: Soliciting pool server 103.152.64.212 Sep 06 07:58:28 minidsp-shd ntpd[29745]: Soliciting pool server 27.124.125.252 Sep 06 07:58:29 minidsp-shd ntpd[29745]: Soliciting pool server 159.196.176.154 Sep 06 07:58:29 minidsp-shd ntpd[29745]: Soliciting pool server 162.159.200.123 Sep 06 07:58:29 minidsp-shd ntpd[29745]: Soliciting pool server 180.150.8.191 Sep 06 07:58:29 minidsp-shd ntpd[29745]: Soliciting pool server 220.158.215.21 Sep 06 07:58:30 minidsp-shd ntpd[29745]: Soliciting pool server 129.250.35.251 Sep 06 07:58:30 minidsp-shd ntpd[29745]: Soliciting pool server 139.180.183.169 Sep 06 07:58:30 minidsp-shd ntpd[29745]: Soliciting pool server 139.180.183.169 Sep 06 07:58:31 minidsp-shd ntpd[29745]: Soliciting pool server 203.14.0.251 Sep 06 07:58:31 minidsp-shd ntpd[29745]: Soliciting pool server 159.196.44.158 Sep 06 07:58:32 minidsp-shd ntpd[29745]: Soliciting pool server 194.195.249.28 Sep 06 07:58:32 minidsp-shd ntpd[29745]: Soliciting pool server 2403:580c:c505:0:6955:67d3:6229:88e7 Sep 06 07:59:06 minidsp-shd volumio[654]: info: Airplay started streaming, receiving metadatas Sep 06 07:59:06 minidsp-shd volumio[654]: verbose: UNSET VOLATILE: Service: inputs Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreCommandRouter::servicePushState Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreStateMachine::pushState Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreCommandRouter::volumioPushState Sep 06 07:59:06 minidsp-shd volumio[654]: info: MRS: Pushing multiroomSync output update for this device Sep 06 07:59:06 minidsp-shd volumio[654]: info: MRS: Pushing multiroomSync output Sep 06 07:59:06 minidsp-shd volumio[654]: info: Airplay started streaming, receiving metadatas Sep 06 07:59:06 minidsp-shd volumio[654]: info: CorePlayQueue::getTrack 0 Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreCommandRouter::volumioStop Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreStateMachine::stop Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreStateMachine::stPlaybackTimer Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreStateMachine::updateTrackBlock Sep 06 07:59:06 minidsp-shd volumio[654]: info: CorePlayQueue::getTrackBlock Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreStateMachine::pushState Sep 06 07:59:06 minidsp-shd volumio[654]: info: CorePlayQueue::getTrack 0 Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreCommandRouter::volumioPushState Sep 06 07:59:06 minidsp-shd volumio[654]: info: MRS: Pushing multiroomSync output update for this device Sep 06 07:59:06 minidsp-shd volumio[654]: info: MRS: Pushing multiroomSync output Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreStateMachine::serviceStop Sep 06 07:59:06 minidsp-shd volumio[654]: info: CorePlayQueue::getTrack 0 Sep 06 07:59:06 minidsp-shd volumio[654]: info: CoreCommandRouter::serviceStop Sep 06 07:59:06 minidsp-shd volumio[654]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 07:59:06 minidsp-shd volumio[654]: TypeError: Cannot read property 'stop' of null Sep 06 07:59:06 minidsp-shd volumio[654]: at ControllerYTMusic.stop (/data/plugins/music_service/ytmusic/index.js:309:30) Sep 06 07:59:06 minidsp-shd volumio[654]: at CoreCommandRouter.serviceStop (/volumio/app/index.js:370:25) Sep 06 07:59:06 minidsp-shd volumio[654]: at CoreStateMachine.serviceStop (/volumio/app/statemachine.js:1259:33) Sep 06 07:59:06 minidsp-shd volumio[654]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1234:19) Sep 06 07:59:06 minidsp-shd volumio[654]: at CoreCommandRouter.volumioStop (/volumio/app/index.js:89:28) Sep 06 07:59:06 minidsp-shd volumio[654]: at AirPlayInterface.prepareAirplayPlayback (/volumio/app/plugins/music_service/airplay_emulation/index.js:543:32) Sep 06 07:59:06 minidsp-shd volumio[654]: at ShairportSyncReaderUDP. (/volumio/app/plugins/music_service/airplay_emulation/index.js:257:12) Sep 06 07:59:06 minidsp-shd volumio[654]: at ShairportSyncReaderUDP.emit (events.js:412:35) Sep 06 07:59:06 minidsp-shd volumio[654]: at ShairportSyncReaderUDP.useData (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-base.js:86:16) Sep 06 07:59:06 minidsp-shd volumio[654]: at Socket. (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-udp.js:21:12) Sep 06 07:59:06 minidsp-shd volumio[654]: at Socket.emit (events.js:400:28) Sep 06 07:59:06 minidsp-shd volumio[654]: at UDP.onMessage [as onmessage] (dgram.js:931:8) Sep 06 07:59:06 minidsp-shd volumio[654]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 07:59:06 minidsp-shd shairport-sync[1158]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 06 07:59:06 minidsp-shd shairport-sync[1158]: Dload Upload Total Spent Left Speed Sep 06 07:59:07 minidsp-shd sudo[29768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 07:58 Sep 06 07:59:07 minidsp-shd sudo[29768]: 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="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:00:28 PM CET" VOLUMIO_VERSION="3.608" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_DEVICENAME="NanoPi Neo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="29ccfe8a9cff19911db4b736879ac117"