-- Logs begin at Thu 2025-05-22 06:55:25 JST, end at Thu 2025-05-22 07:13:40 JST. --
May 22 07:12:02 volumio volumio[1328]: info:
May 22 07:12:02 volumio volumio[1328]: ---------------------------- Client requests Volume 30
May 22 07:12:02 volumio volumio[1328]: info: VolumeController::SetAlsaVolume30
May 22 07:12:02 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:02 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:02 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:02 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:12:03 volumio volumio[1328]: info:
May 22 07:12:03 volumio volumio[1328]: ---------------------------- Client requests Volume NaN
May 22 07:12:03 volumio volumio[1328]: info: VolumeController::SetAlsaVolumeNaN
May 22 07:12:03 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:03 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:03 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:03 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:12:08 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
May 22 07:12:08 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:13 volumio volumio[1328]: info:
May 22 07:12:13 volumio volumio[1328]: ---------------------------- Client requests Volume 30
May 22 07:12:13 volumio volumio[1328]: info: VolumeController::SetAlsaVolume30
May 22 07:12:14 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:14 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:14 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:14 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:12:15 volumio volumio[1328]: info:
May 22 07:12:15 volumio volumio[1328]: ---------------------------- Client requests Volume NaN
May 22 07:12:15 volumio volumio[1328]: info: VolumeController::SetAlsaVolumeNaN
May 22 07:12:15 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:15 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:15 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:15 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:12:20 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
May 22 07:12:20 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:25 volumio volumio[1328]: info:
May 22 07:12:25 volumio volumio[1328]: ---------------------------- Client requests Volume 30
May 22 07:12:25 volumio volumio[1328]: info: VolumeController::SetAlsaVolume30
May 22 07:12:25 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:25 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:25 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:25 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:12:26 volumio volumio[1328]: info:
May 22 07:12:26 volumio volumio[1328]: ---------------------------- Client requests Volume NaN
May 22 07:12:26 volumio volumio[1328]: info: VolumeController::SetAlsaVolumeNaN
May 22 07:12:26 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:26 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:26 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:26 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:12:31 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
May 22 07:12:31 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:36 volumio volumio[1328]: info:
May 22 07:12:36 volumio volumio[1328]: ---------------------------- Client requests Volume 30
May 22 07:12:36 volumio volumio[1328]: info: VolumeController::SetAlsaVolume30
May 22 07:12:36 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:36 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:36 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:36 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:12:38 volumio volumio[1328]: info:
May 22 07:12:38 volumio volumio[1328]: ---------------------------- Client requests Volume NaN
May 22 07:12:38 volumio volumio[1328]: info: VolumeController::SetAlsaVolumeNaN
May 22 07:12:38 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:38 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:38 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:38 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:12:43 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
May 22 07:12:43 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:48 volumio volumio[1328]: info:
May 22 07:12:48 volumio volumio[1328]: ---------------------------- Client requests Volume 30
May 22 07:12:48 volumio volumio[1328]: info: VolumeController::SetAlsaVolume30
May 22 07:12:48 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:48 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:48 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:48 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:12:49 volumio volumio[1328]: info:
May 22 07:12:49 volumio volumio[1328]: ---------------------------- Client requests Volume NaN
May 22 07:12:49 volumio volumio[1328]: info: VolumeController::SetAlsaVolumeNaN
May 22 07:12:49 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:49 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:49 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:49 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:12:54 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
May 22 07:12:54 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:59 volumio volumio[1328]: info:
May 22 07:12:59 volumio volumio[1328]: ---------------------------- Client requests Volume 30
May 22 07:12:59 volumio volumio[1328]: info: VolumeController::SetAlsaVolume30
May 22 07:12:59 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:12:59 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:12:59 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:12:59 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:13:01 volumio volumio[1328]: info:
May 22 07:13:01 volumio volumio[1328]: ---------------------------- Client requests Volume NaN
May 22 07:13:01 volumio volumio[1328]: info: VolumeController::SetAlsaVolumeNaN
May 22 07:13:01 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:13:01 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:01 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:13:01 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:13:06 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
May 22 07:13:06 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:11 volumio volumio[1328]: info:
May 22 07:13:11 volumio volumio[1328]: ---------------------------- Client requests Volume 30
May 22 07:13:11 volumio volumio[1328]: info: VolumeController::SetAlsaVolume30
May 22 07:13:11 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:13:11 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:13:11 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:13:12 volumio volumio[1328]: info:
May 22 07:13:12 volumio volumio[1328]: ---------------------------- Client requests Volume NaN
May 22 07:13:12 volumio volumio[1328]: info: VolumeController::SetAlsaVolumeNaN
May 22 07:13:12 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:13:12 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:12 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:13:12 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:13:17 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
May 22 07:13:17 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:22 volumio volumio[1328]: info:
May 22 07:13:22 volumio volumio[1328]: ---------------------------- Client requests Volume 30
May 22 07:13:22 volumio volumio[1328]: info: VolumeController::SetAlsaVolume30
May 22 07:13:22 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:13:22 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:22 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:13:22 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:13:24 volumio volumio[1328]: info:
May 22 07:13:24 volumio volumio[1328]: ---------------------------- Client requests Volume NaN
May 22 07:13:24 volumio volumio[1328]: info: VolumeController::SetAlsaVolumeNaN
May 22 07:13:24 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:13:24 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:24 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:13:24 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:13:29 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
May 22 07:13:29 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:31 volumio dhcpcd[811]: eth0: carrier lost
May 22 07:13:31 volumio kernel: dwmac-sun8i 1c30000.ethernet eth0: Link is Down
May 22 07:13:31 volumio avahi-daemon[760]: Withdrawing address record for 192.168.223.251 on eth0.
May 22 07:13:31 volumio avahi-daemon[760]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.223.251.
May 22 07:13:31 volumio avahi-daemon[760]: Interface eth0.IPv4 no longer relevant for mDNS.
May 22 07:13:31 volumio volumio[1328]: info: Discovery: A device disappeared from network
May 22 07:13:31 volumio volumio[1328]: info: Discovery: Device volumio disappeared from network
May 22 07:13:31 volumio dhcpcd[811]: eth0: deleting route to 192.168.223.0/24
May 22 07:13:31 volumio dhcpcd[811]: eth0: deleting default route via 192.168.223.1
May 22 07:13:31 volumio ifplugd(eth0)[1003]: Link beat lost.
May 22 07:13:32 volumio ntpd[991]: Deleting interface #4 eth0, 192.168.223.251#123, interface stats: received=251, sent=252, dropped=0, active_time=1040 secs
May 22 07:13:32 volumio ntpd[991]: 23.81.40.154 local addr 192.168.223.251 ->
May 22 07:13:32 volumio ntpd[991]: 133.130.121.141 local addr 192.168.223.251 ->
May 22 07:13:32 volumio ntpd[991]: 172.237.12.44 local addr 192.168.223.251 ->
May 22 07:13:32 volumio ntpd[991]: 139.162.81.45 local addr 192.168.223.251 ->
May 22 07:13:32 volumio ntpd[991]: 118.156.189.22 local addr 192.168.223.251 ->
May 22 07:13:32 volumio ntpd[991]: 160.16.113.133 local addr 192.168.223.251 ->
May 22 07:13:33 volumio dhcpcd[811]: eth0: carrier acquired
May 22 07:13:33 volumio kernel: dwmac-sun8i 1c30000.ethernet eth0: Link is Up - 100Mbps/Full - flow control off
May 22 07:13:33 volumio dhcpcd[811]: eth0: IAID 83:1d:b1:d8
May 22 07:13:33 volumio dhcpcd[811]: eth0: probing address 192.168.223.251/24
May 22 07:13:33 volumio dhcpcd[811]: eth0: soliciting an IPv6 router
May 22 07:13:33 volumio ifplugd(eth0)[1003]: Link beat detected.
May 22 07:13:34 volumio volumio[1328]: info:
May 22 07:13:34 volumio volumio[1328]: ---------------------------- Client requests Volume 30
May 22 07:13:34 volumio volumio[1328]: info: VolumeController::SetAlsaVolume30
May 22 07:13:34 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:13:34 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:34 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:13:34 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:13:35 volumio volumio[1328]: info: Volumio Network Manager: Network status updated: 0
May 22 07:13:35 volumio volumio[1328]: info:
May 22 07:13:35 volumio volumio[1328]: ---------------------------- Client requests Volume NaN
May 22 07:13:35 volumio volumio[1328]: info: VolumeController::SetAlsaVolumeNaN
May 22 07:13:35 volumio volumio[1328]: info: CoreStateMachine::pushState
May 22 07:13:35 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:35 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 07:13:35 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState
May 22 07:13:38 volumio dhcpcd[811]: eth0: using static address 192.168.223.251/24
May 22 07:13:38 volumio dhcpcd[811]: eth0: adding route to 192.168.223.0/24
May 22 07:13:38 volumio dhcpcd[811]: eth0: adding default route via 192.168.223.1
May 22 07:13:38 volumio avahi-daemon[760]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.223.251.
May 22 07:13:38 volumio avahi-daemon[760]: New relevant interface eth0.IPv4 for mDNS.
May 22 07:13:38 volumio avahi-daemon[760]: Registering new address record for 192.168.223.251 on eth0.IPv4.
May 22 07:13:39 volumio volumio[1328]: info: Discovery: adding 55e405f5-a25e-4eee-b880-50dec7a9cf3e
May 22 07:13:39 volumio volumio[1328]: info: Discovery: Found device Volumio
May 22 07:13:39 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
May 22 07:13:39 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
May 22 07:13:39 volumio volumio[1328]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 22 07:13:39 volumio volumio[1328]: Error: The value NaN is not a number
May 22 07:13:39 volumio volumio[1328]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20)
May 22 07:13:39 volumio volumio[1328]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25)
May 22 07:13:39 volumio volumio[1328]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25)
May 22 07:13:39 volumio volumio[1328]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10)
May 22 07:13:39 volumio volumio[1328]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12)
May 22 07:13:39 volumio volumio[1328]: at Browser.emit (events.js:400:28)
May 22 07:13:39 volumio volumio[1328]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14)
May 22 07:13:39 volumio volumio[1328]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7)
May 22 07:13:39 volumio volumio[1328]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5)
May 22 07:13:39 volumio volumio[1328]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21)
May 22 07:13:39 volumio volumio[1328]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11
May 22 07:13:39 volumio volumio[1328]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7)
May 22 07:13:39 volumio volumio[1328]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9)
May 22 07:13:39 volumio volumio[1328]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 22 07:13:39 volumio ntpd[991]: Listen normally on 5 eth0 192.168.223.251:123
May 22 07:13:39 volumio ntpd[991]: new interface(s) found: waking up resolver
May 22 07:13:40 volumio sudo[6282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-22 07:12
May 22 07:13:40 volumio sudo[6282]: 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="d316d397153fbb98c246d670c12f98a120b995a2"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 11 Jan 2025 04:53:42 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="nanopineo-armbian"
VOLUMIO_DEVICENAME="NanoPi Neo"
VOLUMIO_HASH="ce44a88e190e93c6a43956b6226fe39b"