-- Logs begin at Sat 2025-12-20 08:33:12 JST, end at Sat 2025-12-20 14:08:38 JST. -- Dec 20 14:07:24 rivo-b volumiologrotate[2839]: ls: cannot access '/var/log/samba/log.wb-RIVO': No such file or directory Dec 20 14:07:24 rivo-b volumiologrotate[2839]: ls: cannot access 'B': No such file or directory Dec 20 14:08:16 rivo-b volumio5-onboarding[3722]: time=2025-12-20T14:08:16.936+09:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.10.101:54084 Dec 20 14:08:16 rivo-b volumio5-onboarding[3722]: time=2025-12-20T14:08:16.939+09:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.10.101:54085 Dec 20 14:08:16 rivo-b volumio5-onboarding[3722]: time=2025-12-20T14:08:16.965+09:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.10.101:54084 @ 0x175c7e0" latency=19.626017ms timeout=10s Dec 20 14:08:16 rivo-b volumio5-onboarding[3722]: time=2025-12-20T14:08:16.965+09:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.10.101:54084 @ 0x175c7e0" latency=19.534808ms platform=PLATFORM_IOS version=4.251125.0 Dec 20 14:08:16 rivo-b volumio[3486]: info: Received Get System Info Dec 20 14:08:16 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 14:08:16 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 14:08:16 rivo-b volumio[3486]: info: Discovery: Getting this device information Dec 20 14:08:16 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:16 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:16 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 14:08:16 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 20 14:08:16 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 20 14:08:16 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 20 14:08:16 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Dec 20 14:08:16 rivo-b volumio5-onboarding[3722]: time=2025-12-20T14:08:16.998+09:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.10.101:54084 Dec 20 14:08:16 rivo-b volumio5-onboarding[3722]: time=2025-12-20T14:08:16.998+09:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.10.101:54084 Dec 20 14:08:17 rivo-b volumio5-onboarding[3722]: time=2025-12-20T14:08:17.004+09:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.10.101:54193 Dec 20 14:08:17 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 20 14:08:17 rivo-b kernel: aml_spdif_open Dec 20 14:08:17 rivo-b kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Dec 20 14:08:17 rivo-b kernel: spdif_a keep clk continuous Dec 20 14:08:17 rivo-b kernel: aml_spdif_close Dec 20 14:08:17 rivo-b kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Dec 20 14:08:17 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:17 rivo-b volumio[3486]: amixer -c 5 info | grep "HD-AMP1" Dec 20 14:08:17 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:17 rivo-b volumio[3486]: Card hw:5 'HDAMP1'/'D&M Holdings Inc. HD-AMP1 at usb-xhci-hcd.0.auto-1.4.2, high speed' Dec 20 14:08:17 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:17 rivo-b volumio[3486]: amixer -c 5 info | grep "HD-AMP1" Dec 20 14:08:17 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:17 rivo-b volumio[3486]: Card hw:5 'HDAMP1'/'D&M Holdings Inc. HD-AMP1 at usb-xhci-hcd.0.auto-1.4.2, high speed' Dec 20 14:08:17 rivo-b volumio[3486]: Invalid card number. Dec 20 14:08:17 rivo-b volumio[3486]: info: Received Get System Info Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 14:08:17 rivo-b volumio[3486]: info: Discovery: Getting this device information Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:17 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 20 14:08:17 rivo-b volumio5-onboarding[3722]: time=2025-12-20T14:08:17.815+09:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.10.101:54193 @ 0x14abe90" latency=13.915164ms platform=PLATFORM_IOS version=4.251125.0 Dec 20 14:08:17 rivo-b volumio5-onboarding[3722]: time=2025-12-20T14:08:17.817+09:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.10.101:54085,192.168.10.101:54193 @ 0x175c7e0" latency=14.064921ms timeout=10s Dec 20 14:08:17 rivo-b volumio[3486]: info: Received Get System Info Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 14:08:17 rivo-b volumio[3486]: info: Discovery: Getting this device information Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:17 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Dec 20 14:08:17 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 14:08:17 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 20 14:08:18 rivo-b kernel: aml_spdif_open Dec 20 14:08:18 rivo-b kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Dec 20 14:08:18 rivo-b kernel: spdif_a keep clk continuous Dec 20 14:08:18 rivo-b kernel: aml_spdif_close Dec 20 14:08:18 rivo-b kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Dec 20 14:08:18 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:18 rivo-b volumio[3486]: amixer -c 5 info | grep "HD-AMP1" Dec 20 14:08:18 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:18 rivo-b volumio[3486]: Card hw:5 'HDAMP1'/'D&M Holdings Inc. HD-AMP1 at usb-xhci-hcd.0.auto-1.4.2, high speed' Dec 20 14:08:18 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:18 rivo-b volumio[3486]: amixer -c 5 info | grep "HD-AMP1" Dec 20 14:08:18 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:18 rivo-b volumio[3486]: Card hw:5 'HDAMP1'/'D&M Holdings Inc. HD-AMP1 at usb-xhci-hcd.0.auto-1.4.2, high speed' Dec 20 14:08:18 rivo-b volumio[3486]: Invalid card number. Dec 20 14:08:18 rivo-b volumio[3486]: info: Received Get System Info Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 14:08:18 rivo-b volumio[3486]: info: Discovery: Getting this device information Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:18 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 14:08:18 rivo-b volumio[3486]: info: Discovery: Getting this device information Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:18 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 20 14:08:18 rivo-b volumio[3486]: verbose: New Socket.io Connection to 192.168.10.103:3000 from 192.168.10.101 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 20 14:08:18 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: fatal error: concurrent map writes Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 136 [running]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/runtime/maps.fatal({0x9f65b5, 0x15}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/panic.go:1058 +0x24 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/state.(*managerImpl).pluginsChangedEvent(0x16143c0, {0xb1e604, 0x17298a8}, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/state/events.go:279 +0x1f4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/state.(*managerImpl).NotifyPlugins(0x16143c0, {0xb1e604, 0x17298a8}, {0xb216cc, 0x14979c0}, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/state/notify.go:191 +0x34 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/state.(*managerImpl).NotifyAll(0x16143c0, {0xb1e604, 0x17298a8}, {0xb216cc, 0x14979c0}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/state/notify.go:43 +0x304 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: main.(*serverHandler).DeviceDataRequest(0x15170a0, {0xb1e604, 0x17298a8}, {0xb216cc, 0x14979c0}, 0x1729830) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/cmd/server/handlers.go:63 +0xd0 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/server.(*Server).registerHandler.newRequestHandler[...].func4(0x1772030, {0x0, 0x0, 0x0}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/server/handlers.go:113 +0x57c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/server.(*Server).handlePacket.func2() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/server/server.go:177 +0xcc Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/server.(*Server).handlePacket in goroutine 14 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/server/server.go:176 +0x6cc Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 1 [chan receive, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/oklog/run.(*Group).Run(0x1459f40) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/oklog/run@v1.2.0/group.go:43 +0x170 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: main.(*App).Run(0x1550360) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/cmd/server/app.go:107 +0x4b8 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: main.main() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/cmd/server/main.go:30 +0x22c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 17 [syscall, 334 minutes, locked to thread]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: runtime.goexit({}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/asm_arm.s:884 +0x4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 36 [chan receive, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.linkSubscribeAt.func1() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/link_linux.go:2516 +0x2c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.linkSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/link_linux.go:2515 +0x14c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 37 [IO wait, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbff28, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x1521c18, 0x72, 0x1) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).RawRead(0x1521c00, 0x14a0ac8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:717 +0x154 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: os.(*rawConn).Read(0x1492450, 0x14a0ac8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/os/rawconn.go:31 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink/nl.(*NetlinkSocket).Receive(0x1521c40) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/nl/nl_linux.go:898 +0x25c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.linkSubscribeAt.func2() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/link_linux.go:2532 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.linkSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/link_linux.go:2529 +0x2dc Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 38 [chan receive, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.addrSubscribeAt.func1() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/addr_linux.go:358 +0x2c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.addrSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/addr_linux.go:357 +0x154 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 39 [IO wait, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbfe78, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x1521cd8, 0x72, 0x1) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).RawRead(0x1521cc0, 0x1477008) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:717 +0x154 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: os.(*rawConn).Read(0x1426598, 0x1477008) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/os/rawconn.go:31 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink/nl.(*NetlinkSocket).Receive(0x1521d00) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/nl/nl_linux.go:898 +0x25c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.addrSubscribeAt.func2() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/addr_linux.go:374 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.addrSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/addr_linux.go:371 +0x2e4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 40 [chan receive, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.routeSubscribeAt.func1() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/route_linux.go:1770 +0x2c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.routeSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/route_linux.go:1769 +0x154 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 41 [IO wait, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbfdc8, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x1521d58, 0x72, 0x1) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).RawRead(0x1521d40, 0x1476ff0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:717 +0x154 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: os.(*rawConn).Read(0x1426580, 0x1476ff0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/os/rawconn.go:31 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink/nl.(*NetlinkSocket).Receive(0x1521d80) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/nl/nl_linux.go:898 +0x25c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.routeSubscribeAt.func2() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/route_linux.go:1786 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.routeSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/route_linux.go:1783 +0x2e4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 42 [select, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/volumio/net.SubscribeNetworkInfo.func1(0x14a84b0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/volumio/net/info.go:83 +0x11c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/volumio/wifi.(*managerImpl).subscribe(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/volumio/wifi/manager.go:134 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/volumio/wifi.NewManager in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/volumio/wifi/manager.go:128 +0x3f8 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 43 [chan receive, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.linkSubscribeAt.func1() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/link_linux.go:2516 +0x2c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.linkSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/link_linux.go:2515 +0x14c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 44 [IO wait, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbfd18, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x1521e98, 0x72, 0x1) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).RawRead(0x1521e80, 0x1477020) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:717 +0x154 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: os.(*rawConn).Read(0x14265b0, 0x1477020) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/os/rawconn.go:31 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink/nl.(*NetlinkSocket).Receive(0x1521ec0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/nl/nl_linux.go:898 +0x25c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.linkSubscribeAt.func2() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/link_linux.go:2532 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.linkSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/link_linux.go:2529 +0x2dc Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 45 [chan receive, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.addrSubscribeAt.func1() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/addr_linux.go:358 +0x2c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.addrSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/addr_linux.go:357 +0x154 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 46 [IO wait, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbfc68, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x1614018, 0x72, 0x1) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).RawRead(0x1614000, 0x1477038) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:717 +0x154 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: os.(*rawConn).Read(0x14265c8, 0x1477038) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/os/rawconn.go:31 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink/nl.(*NetlinkSocket).Receive(0x1614040) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/nl/nl_linux.go:898 +0x25c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.addrSubscribeAt.func2() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/addr_linux.go:374 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.addrSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/addr_linux.go:371 +0x2e4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 47 [chan receive, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.routeSubscribeAt.func1() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/route_linux.go:1770 +0x2c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.routeSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/route_linux.go:1769 +0x154 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 48 [IO wait, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbfbb8, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x1614098, 0x72, 0x1) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).RawRead(0x1614080, 0x1477050) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:717 +0x154 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: os.(*rawConn).Read(0x14265e0, 0x1477050) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/os/rawconn.go:31 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink/nl.(*NetlinkSocket).Receive(0x16140c0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/nl/nl_linux.go:898 +0x25c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/vishvananda/netlink.routeSubscribeAt.func2() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/route_linux.go:1786 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/vishvananda/netlink.routeSubscribeAt in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/vishvananda/netlink@v1.3.1/route_linux.go:1783 +0x2e4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 49 [select, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/volumio/net.SubscribeNetworkInfo.func1(0x16ea000) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/volumio/net/info.go:83 +0x11c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/volumio/eth.(*managerImpl).subscribe(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/volumio/eth/manager.go:76 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/volumio/eth.NewManager in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/volumio/eth/manager.go:70 +0x384 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 53 [runnable]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: syscall.Syscall(0x3, 0xb, 0x163e000, 0x1000) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/syscall/syscall_linux.go:73 +0x8 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: syscall.read(0xb, {0x163e000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/syscall/zsyscall_linux_arm.go:736 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: syscall.Read(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/syscall/syscall_unix.go:183 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.ignoringEINTRIO(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:745 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).Read(0x154a780, {0x163e000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:161 +0x264 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).Read(0x154a780, {0x163e000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_posix.go:55 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*conn).Read(0x15126e8, {0x163e000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/net.go:194 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).fill(0x1550630) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:113 +0x10c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).Peek(0x1550630, 0x2) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:152 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).read(0x1552688, 0x2) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:371 +0x28 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).advanceFrame(0x1552688) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:809 +0xa4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).NextReader(0x1552688) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:1009 +0xb4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).ReadMessage(0x1552688) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:1093 +0x1c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/socketio.(*Client).readLoop(0x1614100) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/socketio/client.go:151 +0x10c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/socketio.(*Client).connect in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/socketio/client.go:134 +0x73c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 54 [select]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/socketio.(*Client).loop(0x1614100) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/socketio/client.go:176 +0xe8 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/socketio.(*Client).connect in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/socketio/client.go:135 +0x784 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 55 [chan receive, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/godbus/dbus/v5.newConn.func1() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/godbus/dbus/v5@v5.1.0/conn.go:303 +0x40 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/godbus/dbus/v5.newConn in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/godbus/dbus/v5@v5.1.0/conn.go:302 +0x528 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 56 [IO wait, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbfa58, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x154aa18, 0x72, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).ReadMsg(0x154aa00, {0x16e85b0, 0x10, 0x10}, {0x1700018, 0x1000, 0x1000}, 0x40000000) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:302 +0x2c0 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).readMsg(0x154aa00, {0x16e85b0, 0x10, 0x10}, {0x1700018, 0x1000, 0x1000}, 0x40000000) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_posix.go:78 +0x58 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*UnixConn).readMsg(0x15129b0, {0x16e85b0, 0x10, 0x10}, {0x1700018, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/unixsock_posix.go:115 +0x58 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*UnixConn).ReadMsgUnix(0x15129b0, {0x16e85b0, 0x10, 0x10}, {0x1700018, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/unixsock.go:143 +0x58 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/godbus/dbus/v5.(*oobReader).Read(0x1700008, {0x16e85b0, 0x10, 0x10}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/godbus/dbus/v5@v5.1.0/transport_unix.go:21 +0x50 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: io.ReadAtLeast({0xb1a4c8, 0x1700008}, {0x16e85b0, 0x10, 0x10}, 0x10) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/io/io.go:335 +0x90 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: io.ReadFull(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/io/io.go:354 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/godbus/dbus/v5.(*unixTransport).ReadMessage(0x1516770) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/godbus/dbus/v5@v5.1.0/transport_unix.go:91 +0x100 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/godbus/dbus/v5.(*Conn).inWorker(0x154c500) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/godbus/dbus/v5@v5.1.0/conn.go:390 +0x44 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/godbus/dbus/v5.(*Conn).Auth in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/godbus/dbus/v5@v5.1.0/auth.go:118 +0x7dc Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 21 [select, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/OpenPrinting/go-avahi.(*eventqueue[...]).proc(0xb20730) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/!open!printing/go-avahi@v0.0.0-20250813163007-dd9db1c4a6e9/eventqueue.go:78 +0x108 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/OpenPrinting/go-avahi.(*eventqueue[...]).Push in goroutine 17 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/!open!printing/go-avahi@v0.0.0-20250813163007-dd9db1c4a6e9/eventqueue.go:41 +0x198 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 20 [select, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/OpenPrinting/go-avahi.(*eventqueue[...]).proc(0xb20730) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/!open!printing/go-avahi@v0.0.0-20250813163007-dd9db1c4a6e9/eventqueue.go:78 +0x108 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/OpenPrinting/go-avahi.(*eventqueue[...]).Push in goroutine 16 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/!open!printing/go-avahi@v0.0.0-20250813163007-dd9db1c4a6e9/eventqueue.go:41 +0x198 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 91 [IO wait]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbf8f8, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x14ac8d8, 0x72, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).Read(0x14ac8c0, {0x1608000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).Read(0x14ac8c0, {0x1608000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_posix.go:55 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*conn).Read(0x14925a8, {0x1608000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/net.go:194 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*connReader).Read(0x151c240, {0x1608000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:798 +0x170 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).fill(0x1400450) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:113 +0x10c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).Peek(0x1400450, 0x4) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:152 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*conn).serve(0x173a8a0, {0xb1e604, 0x1519e90}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:2137 +0x8a4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by net/http.(*Server).Serve in goroutine 61 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3454 +0x430 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 60 [select, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/ble.(*blePacketConn).loop(0x14737a0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/ble/conn.go:163 +0xdc Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/conn/ble.Listen in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/ble/conn.go:156 +0x7a8 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 61 [IO wait]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbf9a8, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x154ace8, 0x72, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).Accept(0x154acd0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:620 +0x284 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).accept(0x154acd0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_unix.go:172 +0x20 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*TCPListener).accept(0x1550c00) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*TCPListener).Accept(0x1550c00) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/tcpsock.go:380 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*Server).Serve(0x15589a8, {0xb1dd10, 0x1550c00}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3424 +0x2dc Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/ws.Listen.func2() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/ws/conn.go:140 +0x34 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/conn/ws.Listen in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/ws/conn.go:139 +0x398 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 62 [select, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/ble.(*blePacketConn).ReadFrom(0x14737a0, {0x1662000, 0x4000, 0x4000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/ble/conn.go:362 +0x8c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/multi.(*multiPacketConn).readConnLoop(0x1546c00, {0xb1fba0, 0x14737a0}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/multi/conn.go:256 +0x98 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/conn/multi.New in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/multi/conn.go:103 +0x440 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 63 [select]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/ws.(*wsPacketConn).ReadFrom(0x1546ba0, {0x1632000, 0x4000, 0x4000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/ws/conn.go:156 +0x98 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/multi.(*multiPacketConn).readConnLoop(0x1546c00, {0xb1fbc8, 0x1546ba0}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/multi/conn.go:256 +0x98 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/conn/multi.New in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/multi/conn.go:103 +0x440 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 64 [select, 2 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/multi.New.func1() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/multi/conn.go:111 +0xec Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/conn/multi.New in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/multi/conn.go:106 +0x5f8 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 12 [syscall, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: os/signal.signal_recv() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/sigqueue.go:152 +0x34 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: os/signal.loop() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/os/signal/signal_unix.go:23 +0x14 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by os/signal.Notify.func1.1 in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/os/signal/signal.go:152 +0x28 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 13 [select, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: os/signal.NotifyContext.func1() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/os/signal/signal.go:289 +0x88 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by os/signal.NotifyContext in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/os/signal/signal.go:288 +0x180 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 14 [select]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/multi.(*multiPacketConn).ReadFrom(0x1546c00, {0x1760000, 0x4000, 0x4000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/multi/conn.go:345 +0x80 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/server.(*Server).Run(0x16147c0, {0xb1e700, 0x1718aa0}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/server/server.go:203 +0xf0 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: main.(*App).Run.func2() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/cmd/server/app.go:82 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/oklog/run.(*Group).Run.func1({0x17581b0, 0x1427750}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/oklog/run@v1.2.0/group.go:38 +0x24 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/oklog/run.(*Group).Run in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/oklog/run@v1.2.0/group.go:37 +0x7c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 15 [chan receive, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/discovery/ble.(*managerImpl).Run(0x1516760, {0xb1e700, 0x1718aa0}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/discovery/ble/manager.go:86 +0xa4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: main.(*App).Run.func4() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/cmd/server/app.go:91 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/oklog/run.(*Group).Run.func1({0x17581c0, 0x1427760}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/oklog/run@v1.2.0/group.go:38 +0x24 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/oklog/run.(*Group).Run in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/oklog/run@v1.2.0/group.go:37 +0x7c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 16 [select, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/discovery/localnet.(*managerImpl).Run(0x15198c0, {0xb1e700, 0x1718aa0}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/discovery/localnet/manager.go:163 +0xd4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: main.(*App).Run.func6() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/cmd/server/app.go:99 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/oklog/run.(*Group).Run.func1({0x17581e0, 0x1427768}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/oklog/run@v1.2.0/group.go:38 +0x24 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/oklog/run.(*Group).Run in goroutine 1 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/oklog/run@v1.2.0/group.go:37 +0x7c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 104 [chan receive, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: tinygo.org/x/bluetooth.(*Advertisement).handleDBusSignals(0x15195f0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/devgianlu/bluetooth@v0.0.0-20250821171006-5a9aa9913b10/gap_linux.go:576 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by tinygo.org/x/bluetooth.(*Advertisement).Start in goroutine 15 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/devgianlu/bluetooth@v0.0.0-20250821171006-5a9aa9913b10/gap_linux.go:169 +0x47c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 24 [IO wait]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbf848, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x175e0b8, 0x72, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).Read(0x175e0a0, {0x15f3000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).Read(0x175e0a0, {0x15f3000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_posix.go:55 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*conn).Read(0x1512180, {0x15f3000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/net.go:194 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).fill(0x14aa690) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:113 +0x10c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).Peek(0x14aa690, 0x2) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:152 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).read(0x15ae9c8, 0x2) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:371 +0x28 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).advanceFrame(0x15ae9c8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:809 +0xa4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).NextReader(0x15ae9c8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:1009 +0xb4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).ReadMessage(0x15ae9c8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:1093 +0x1c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/ws.Listen.func1({0xb1dfc8, 0x149e0a8}, 0x15e8168) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/ws/conn.go:125 +0x564 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.HandlerFunc.ServeHTTP(0x1517040, {0xb1dfc8, 0x149e0a8}, 0x15e8168) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:2294 +0x34 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.serverHandler.ServeHTTP({0x15589a8}, {0xb1dfc8, 0x149e0a8}, 0x15e8168) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3301 +0xe0 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*conn).serve(0x14d8000, {0xb1e604, 0x1519e90}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:2102 +0x670 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by net/http.(*Server).Serve in goroutine 61 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3454 +0x430 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 106 [select, 334 minutes]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/OpenPrinting/go-avahi.(*eventqueue[...]).proc(0xb20730) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/!open!printing/go-avahi@v0.0.0-20250813163007-dd9db1c4a6e9/eventqueue.go:78 +0x108 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/OpenPrinting/go-avahi.(*eventqueue[...]).Push in goroutine 17 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/!open!printing/go-avahi@v0.0.0-20250813163007-dd9db1c4a6e9/eventqueue.go:41 +0x198 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 87 [IO wait]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbf6e8, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x14ac478, 0x72, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).Read(0x14ac460, {0x1566000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).Read(0x14ac460, {0x1566000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_posix.go:55 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*conn).Read(0x1492298, {0x1566000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/net.go:194 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*connReader).Read(0x164c020, {0x1566000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:798 +0x170 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).fill(0x1550030) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:113 +0x10c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).Peek(0x1550030, 0x4) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:152 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*conn).serve(0x173a0c0, {0xb1e604, 0x1519e90}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:2137 +0x8a4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by net/http.(*Server).Serve in goroutine 61 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3454 +0x430 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 25 [IO wait]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbf638, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x175e108, 0x72, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).Read(0x175e0f0, {0x1604000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).Read(0x175e0f0, {0x1604000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_posix.go:55 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*conn).Read(0x1512190, {0x1604000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/net.go:194 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*connReader).Read(0x151c1e0, {0x1604000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:798 +0x170 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).fill(0x14003c0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:113 +0x10c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).Peek(0x14003c0, 0x4) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:152 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*conn).serve(0x14d8060, {0xb1e604, 0x1519e90}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:2137 +0x8a4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by net/http.(*Server).Serve in goroutine 61 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3454 +0x430 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 26 [IO wait]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbf588, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x175e158, 0x72, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).Read(0x175e140, {0x1568000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).Read(0x175e140, {0x1568000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_posix.go:55 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*conn).Read(0x15121a0, {0x1568000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/net.go:194 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*connReader).Read(0x164c080, {0x1568000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:798 +0x170 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).fill(0x15500c0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:113 +0x10c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).Peek(0x15500c0, 0x4) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:152 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*conn).serve(0x14d8120, {0xb1e604, 0x1519e90}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:2137 +0x8a4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by net/http.(*Server).Serve in goroutine 61 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3454 +0x430 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 89 [runnable]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: fmt.Sprintf({0x9e9101, 0x7}, {0x1789cbc, 0x2, 0x2}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/fmt/print.go:237 +0xa0 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/multi.(*multiAddr).String(0x175c7e0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/multi/addr.go:99 +0x228 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/server.(*Server).EmitEvent(0x16147c0, {0xb1bec8, 0x175c7e0}, 0xd, {0xb18438, 0x164cc20}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/server/server.go:73 +0x28 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/server.(*peerImpl).EmitPluginsChangedEvent(0x1496400, 0x164cc20) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/server/peer.go:166 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/state.(*managerImpl).NotifyPlugins(0x16143c0, {0xb1e604, 0x17286d8}, {0xb216cc, 0x1496400}, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/state/notify.go:196 +0x6c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/state.(*managerImpl).NotifyAll(0x16143c0, {0xb1e604, 0x17286d8}, {0xb216cc, 0x1496400}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/state/notify.go:43 +0x304 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: main.(*serverHandler).DeviceDataRequest(0x15170a0, {0xb1e604, 0x17286d8}, {0xb216cc, 0x1496400}, 0x1728420) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/cmd/server/handlers.go:63 +0xd0 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/server.(*Server).registerHandler.newRequestHandler[...].func4(0x14aa870, {0x0, 0x0, 0x0}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/server/handlers.go:113 +0x57c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/server.(*Server).handlePacket.func2() Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/server/server.go:177 +0xcc Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by github.com/VolumioTeam/volumio5-device-gateway/server.(*Server).handlePacket in goroutine 14 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/server/server.go:176 +0x6cc Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 107 [IO wait]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbf798, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x160a018, 0x72, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).Read(0x160a000, {0x189e000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).Read(0x160a000, {0x189e000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_posix.go:55 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*conn).Read(0x15f0010, {0x189e000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/net.go:194 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).fill(0x1550de0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:113 +0x10c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).Peek(0x1550de0, 0x2) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:152 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).read(0x15520d8, 0x2) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:371 +0x28 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).advanceFrame(0x15520d8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:809 +0xa4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).NextReader(0x15520d8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:1009 +0xb4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/gorilla/websocket.(*Conn).ReadMessage(0x15520d8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /root/go/pkg/mod/github.com/gorilla/websocket@v1.5.3/conn.go:1093 +0x1c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: github.com/VolumioTeam/volumio5-device-gateway/conn/ws.Listen.func1({0xb1dfc8, 0x1548be8}, 0x15584d8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /src/conn/ws/conn.go:125 +0x564 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.HandlerFunc.ServeHTTP(0x1517040, {0xb1dfc8, 0x1548be8}, 0x15584d8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:2294 +0x34 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.serverHandler.ServeHTTP({0x15589a8}, {0xb1dfc8, 0x1548be8}, 0x15584d8) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3301 +0xe0 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*conn).serve(0x1473680, {0xb1e604, 0x1519e90}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:2102 +0x670 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by net/http.(*Server).Serve in goroutine 61 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3454 +0x430 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 30 [IO wait]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbf4d8, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x175e838, 0x72, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).Read(0x175e820, {0x160c000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).Read(0x175e820, {0x160c000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_posix.go:55 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*conn).Read(0x1512638, {0x160c000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/net.go:194 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*connReader).Read(0x151c2a0, {0x160c000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:798 +0x170 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).fill(0x14004e0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:113 +0x10c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).Peek(0x14004e0, 0x4) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:152 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*conn).serve(0x14d8ba0, {0xb1e604, 0x1519e90}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:2137 +0x8a4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by net/http.(*Server).Serve in goroutine 61 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3454 +0x430 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: goroutine 31 [IO wait]: Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.runtime_pollWait(0xf5cbf428, 0x72) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).wait(0x175e888, 0x72, 0x0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*pollDesc).waitRead(...) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: internal/poll.(*FD).Read(0x175e870, {0x161a000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*netFD).Read(0x175e870, {0x161a000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/fd_posix.go:55 +0x38 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net.(*conn).Read(0x1512640, {0x161a000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/net.go:194 +0x48 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*connReader).Read(0x151c3a0, {0x161a000, 0x1000, 0x1000}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:798 +0x170 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).fill(0x14005d0) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:113 +0x10c Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: bufio.(*Reader).Peek(0x14005d0, 0x4) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/bufio/bufio.go:152 +0x68 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: net/http.(*conn).serve(0x14d8c00, {0xb1e604, 0x1519e90}) Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:2137 +0x8a4 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: created by net/http.(*Server).Serve in goroutine 61 Dec 20 14:08:19 rivo-b volumio5-onboarding[3722]: /usr/local/go/src/net/http/server.go:3454 +0x430 Dec 20 14:08:19 rivo-b systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Dec 20 14:08:19 rivo-b systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Dec 20 14:08:19 rivo-b systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Dec 20 14:08:19 rivo-b systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Dec 20 14:08:19 rivo-b systemd[1]: Stopped Volumio5 Onboarding Server. Dec 20 14:08:19 rivo-b systemd[1]: Started Volumio5 Onboarding Server. Dec 20 14:08:19 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:19.521+09:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z Dec 20 14:08:19 rivo-b volumio[3486]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Dec 20 14:08:19 rivo-b volumio[3486]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Dec 20 14:08:19 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:19.574+09:00 level=INFO msg="listening for BLE messages" address=50:41:1C:59:C2:C1%00 Dec 20 14:08:19 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:19.575+09:00 level=INFO msg="listening for WebSocket messages" address=[::]:7331 Dec 20 14:08:19 rivo-b volumio[3486]: info: Received Get System Info Dec 20 14:08:19 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 14:08:19 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 14:08:19 rivo-b volumio[3486]: info: Discovery: Getting this device information Dec 20 14:08:19 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:19 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:19 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 14:08:19 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 20 14:08:19 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 20 14:08:19 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:19.593+09:00 level=INFO msg="BLE descriptor updated" deviceId=e908e20e7a1ff210f2f045887cf5e9c0 deviceName="Rivo B" deviceModel=0x31a20b0 Dec 20 14:08:19 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:19.593+09:00 level=INFO msg="mDNS descriptor updated" deviceId=e908e20e7a1ff210f2f045887cf5e9c0 deviceName="Rivo B" deviceModel=0x31a20b0 Dec 20 14:08:19 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:19.606+09:00 level=INFO msg="bootstrapping state" hasInternet=true Dec 20 14:08:19 rivo-b volumio[3486]: info: Received Get System Info Dec 20 14:08:19 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 14:08:19 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 14:08:19 rivo-b volumio[3486]: info: Discovery: Getting this device information Dec 20 14:08:19 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:19 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:19 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 14:08:19 rivo-b volumio-remote-updater[2840]: No test mode Dec 20 14:08:19 rivo-b volumio-remote-updater[2840]: No alpha test mode Dec 20 14:08:20 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:20.224+09:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.10.101:54215 Dec 20 14:08:20 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:20.226+09:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.10.101:54216 Dec 20 14:08:20 rivo-b volumio[3486]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 20 14:08:20 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 20 14:08:20 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 14:08:20 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 14:08:20 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 20 14:08:21 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 14:08:21 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 14:08:21 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 20 14:08:21 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:21.331+09:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.10.101:54215 Dec 20 14:08:21 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:21.331+09:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.10.101:54215 Dec 20 14:08:21 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:21.340+09:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.10.101:54219 Dec 20 14:08:22 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 14:08:22 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 20 14:08:24 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:24.361+09:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=AP9XwwlsRUeq43RvmvtskFwBzS03 tokenExpiry=2025-12-20T15:08:24.361+09:00 Dec 20 14:08:25 rivo-b volumiologrotate[2839]: ls: cannot access '/var/log/samba/log.wb-RIVO': No such file or directory Dec 20 14:08:25 rivo-b volumiologrotate[2839]: ls: cannot access 'B': No such file or directory Dec 20 14:08:33 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:33.562+09:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.10.101:54219,192.168.10.101:54216 @ 0x33fe390" latency=16.576646ms platform=PLATFORM_IOS version=4.251125.0 Dec 20 14:08:33 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:33.564+09:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.10.101:54219,192.168.10.101:54216 @ 0x33fe390" latency=15.94328ms timeout=10s Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 20 14:08:33 rivo-b volumio[3486]: info: Received Get System Info Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 14:08:33 rivo-b volumio[3486]: info: Discovery: Getting this device information Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:33 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Dec 20 14:08:33 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 14:08:33 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 20 14:08:33 rivo-b kernel: aml_spdif_open Dec 20 14:08:33 rivo-b kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Dec 20 14:08:33 rivo-b kernel: spdif_a keep clk continuous Dec 20 14:08:33 rivo-b kernel: aml_spdif_close Dec 20 14:08:33 rivo-b kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Dec 20 14:08:33 rivo-b volumio[3486]: Invalid card number. Dec 20 14:08:33 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:33 rivo-b volumio[3486]: amixer -c 5 info | grep "HD-AMP1" Dec 20 14:08:33 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:33 rivo-b volumio[3486]: Card hw:5 'HDAMP1'/'D&M Holdings Inc. HD-AMP1 at usb-xhci-hcd.0.auto-1.4.2, high speed' Dec 20 14:08:33 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:33 rivo-b volumio[3486]: amixer -c 5 info | grep "HD-AMP1" Dec 20 14:08:34 rivo-b volumio[3486]: xcb_connection_has_error() returned true Dec 20 14:08:34 rivo-b volumio[3486]: Card hw:5 'HDAMP1'/'D&M Holdings Inc. HD-AMP1 at usb-xhci-hcd.0.auto-1.4.2, high speed' Dec 20 14:08:34 rivo-b volumio[3486]: info: Received Get System Info Dec 20 14:08:34 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 14:08:34 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 14:08:34 rivo-b volumio[3486]: info: Discovery: Getting this device information Dec 20 14:08:34 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:34 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:34 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 14:08:34 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:34 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:34 rivo-b volumio5-onboarding[23732]: time=2025-12-20T14:08:34.099+09:00 level=INFO msg="continue navigation request" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.10.101:54219,192.168.10.101:54216 @ 0x33fe390" latency=14.63871ms timeout=10s from=APP_PAGE_ROOT Dec 20 14:08:34 rivo-b sudo[23836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 14:08:34 rivo-b sudo[23836]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 14:08:34 rivo-b sudo[23836]: pam_unix(sudo:session): session closed for user root Dec 20 14:08:34 rivo-b sudo[23838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 14:08:34 rivo-b sudo[23838]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 14:08:34 rivo-b sudo[23838]: pam_unix(sudo:session): session closed for user root Dec 20 14:08:34 rivo-b volumio[3486]: verbose: New Socket.io Connection to 192.168.10.103 from 192.168.10.101 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Dec 20 14:08:35 rivo-b sudo[23848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 14:08:35 rivo-b sudo[23848]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 14:08:35 rivo-b sudo[23848]: pam_unix(sudo:session): session closed for user root Dec 20 14:08:35 rivo-b sudo[23849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 14:08:35 rivo-b sudo[23849]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 14:08:35 rivo-b sudo[23849]: pam_unix(sudo:session): session closed for user root Dec 20 14:08:35 rivo-b volumio[3486]: verbose: New Socket.io Connection to 192.168.10.103 from 192.168.10.101 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:35 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 14:08:35 rivo-b volumio[3486]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 20 14:08:35 rivo-b volumio[3486]: info: Received Get System Info Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 14:08:35 rivo-b volumio[3486]: info: Discovery: Getting this device information Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:35 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::volumioGetState Dec 20 14:08:35 rivo-b volumio[3486]: info: CorePlayQueue::getTrack 0 Dec 20 14:08:35 rivo-b volumio[3486]: info: Listing playlists Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 14:08:35 rivo-b volumio[3486]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 20 14:08:37 rivo-b volumio[3486]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 14:08:37 rivo-b volumio[3486]: Error: read ECONNRESET Dec 20 14:08:37 rivo-b volumio[3486]: at TCP.onStreamRead (internal/stream_base_commons.js:209:20) { Dec 20 14:08:37 rivo-b volumio[3486]: errno: -104, Dec 20 14:08:37 rivo-b volumio[3486]: code: 'ECONNRESET', Dec 20 14:08:37 rivo-b volumio[3486]: syscall: 'read' Dec 20 14:08:37 rivo-b volumio[3486]: } Dec 20 14:08:37 rivo-b volumio[3486]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 14:08:38 rivo-b sudo[23880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-20 14:07 Dec 20 14:08:38 rivo-b sudo[23880]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 07:07:40 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="90457dc663650a5d2f936402ef6c7dc1"