Oct 12 11:16:04 volumio volumio[21959]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 12 11:16:19 volumio pulseaudio[20386]: W: [pulseaudio] module-loopback.c: Too many underruns, increasing latency to 352.45 ms Oct 12 11:16:45 volumio sshd[24914]: Accepted password for volumio from 10.0.0.103 port 61343 ssh2 Oct 12 11:16:45 volumio sshd[24914]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Oct 12 11:16:45 volumio systemd-logind[683]: New session 221 of user volumio. Oct 12 11:16:45 volumio systemd[1]: Started session-221.scope - Session 221 of User volumio. Oct 12 11:16:45 volumio sshd[24914]: pam_env(sshd:session): deprecated reading of user environment enabled Oct 12 11:16:46 volumio volumio[21959]: info: CoreCommandRouter::volumioGetState Oct 12 11:16:46 volumio sshd[24925]: Received disconnect from 10.0.0.103 port 61343:11: disconnected by user Oct 12 11:16:46 volumio sshd[24925]: Disconnected from user volumio 10.0.0.103 port 61343 Oct 12 11:16:46 volumio sshd[24914]: pam_unix(sshd:session): session closed for user volumio Oct 12 11:16:46 volumio systemd[1]: session-221.scope: Deactivated successfully. Oct 12 11:16:46 volumio systemd-logind[683]: Session 221 logged out. Waiting for processes to exit. Oct 12 11:16:46 volumio systemd-logind[683]: Removed session 221. Oct 12 11:17:19 volumio sshd[25010]: Accepted password for volumio from 10.0.0.103 port 61379 ssh2 Oct 12 11:17:19 volumio sshd[25010]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Oct 12 11:17:19 volumio systemd-logind[683]: New session 222 of user volumio. Oct 12 11:17:19 volumio systemd[1]: Started session-222.scope - Session 222 of User volumio. Oct 12 11:17:20 volumio sshd[25010]: pam_env(sshd:session): deprecated reading of user environment enabled Oct 12 11:17:20 volumio sudo[25025]: volumio : PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/sh -c 'ls -la /var/lib/bluetooth/00:1A:7D:DA:71:11/cache/ 2>/dev/null; for f in /var/lib/bluetooth/00:1A:7D:DA:71:11/cache/*; do echo "== $f =="; wc -c $f; grep -c ServiceRecord $f 2>/dev/null; done; cat /var/lib/bluetooth/00:1A:7D:DA:71:11/04:24:05:08:F1:7E/info 2>/dev/null | grep -E "Services|Trusted"' Oct 12 11:17:20 volumio sudo[25025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 11:17:20 volumio sudo[25025]: pam_unix(sudo:session): session closed for user root Oct 12 11:17:20 volumio sshd[25022]: Received disconnect from 10.0.0.103 port 61379:11: disconnected by user Oct 12 11:17:20 volumio sshd[25022]: Disconnected from user volumio 10.0.0.103 port 61379 Oct 12 11:17:20 volumio sshd[25010]: pam_unix(sshd:session): session closed for user volumio Oct 12 11:17:20 volumio systemd[1]: session-222.scope: Deactivated successfully. Oct 12 11:17:20 volumio systemd-logind[683]: Session 222 logged out. Waiting for processes to exit. Oct 12 11:17:20 volumio systemd-logind[683]: Removed session 222. Oct 12 11:17:34 volumio sshd[25055]: Accepted password for volumio from 10.0.0.103 port 61396 ssh2 Oct 12 11:17:34 volumio sshd[25055]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Oct 12 11:17:34 volumio systemd-logind[683]: New session 223 of user volumio. Oct 12 11:17:34 volumio systemd[1]: Started session-223.scope - Session 223 of User volumio. Oct 12 11:17:34 volumio sshd[25055]: pam_env(sshd:session): deprecated reading of user environment enabled Oct 12 11:17:34 volumio sudo[25069]: volumio : PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/bluetoothctl trust 04:24:05:08:F1:7E Oct 12 11:17:34 volumio sudo[25069]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 11:17:35 volumio bluetoothd[24450]: Path / reserved for Adv Monitor app :1.6157 Oct 12 11:17:35 volumio bluetoothd[24450]: Adv Monitor app :1.6157 disconnected from D-Bus Oct 12 11:17:35 volumio sudo[25069]: pam_unix(sudo:session): session closed for user root Oct 12 11:17:35 volumio bluetoothd[24450]: profiles/audio/avrcp.c:avrcp_disconnect() path /org/bluez/hci0/dev_04_24_05_08_F1_7E Oct 12 11:17:35 volumio bluetoothd[24450]: profiles/audio/avrcp.c:controller_destroy() 0x1c6ae50 Oct 12 11:17:35 volumio bluetoothd[24450]: profiles/audio/avrcp.c:target_destroy() 0x1c7f3c0 Oct 12 11:17:35 volumio thd[24793]: Error reading device '/dev/input/event2' Oct 12 11:17:35 volumio systemd[1]: Stopping triggerhappy.service - triggerhappy global hotkey daemon... Oct 12 11:17:35 volumio volumio[21959]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 12 11:17:35 volumio systemd[1]: triggerhappy.service: Deactivated successfully. Oct 12 11:17:35 volumio systemd[1]: Stopped triggerhappy.service - triggerhappy global hotkey daemon. Oct 12 11:17:35 volumio volumio[21959]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 12 11:17:35 volumio systemd[1]: Starting triggerhappy.service - triggerhappy global hotkey daemon... Oct 12 11:17:35 volumio thd[25074]: Unable to parse trigger line: Oct 12 11:17:35 volumio thd[25074]: Unable to parse trigger line: Oct 12 11:17:35 volumio systemd[1]: Started triggerhappy.service - triggerhappy global hotkey daemon. Oct 12 11:17:35 volumio volumio[21959]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 12 11:17:37 volumio bluetoothd[24450]: No matching connection for device Oct 12 11:17:40 volumio rfkill[25099]: unblock set for type bluetooth Oct 12 11:17:40 volumio bluetoothd[24450]: profiles/audio/media.c:media_endpoint_async_call() Calling SelectConfiguration: name = :1.1321 path = /MediaEndpoint/A2DPSink/sbc Oct 12 11:17:40 volumio bluetoothd[24450]: profiles/audio/media.c:media_endpoint_async_call() Calling SetConfiguration: name = :1.1321 path = /MediaEndpoint/A2DPSink/sbc Oct 12 11:17:41 volumio bluetoothd[24450]: profiles/audio/avrcp.c:avrcp_connect() path /org/bluez/hci0/dev_04_24_05_08_F1_7E Oct 12 11:17:41 volumio bluetoothd[24450]: profiles/audio/avrcp.c:controller_init() 0x1c9e738 version 0x0106 Oct 12 11:17:41 volumio bluetoothd[24450]: profiles/audio/avrcp.c:controller_init() 0x1c9e738 OBEX PSM 0x1001 Oct 12 11:17:41 volumio bluetoothd[24450]: profiles/audio/avrcp.c:target_init() 0x1c5c5c0 version 0x0104 Oct 12 11:17:41 volumio kernel: input: 一加 Ace 6T (AVRCP) as /devices/virtual/input/input17 Oct 12 11:17:41 volumio bluetoothd[24450]: profiles/audio/avrcp.c:handle_vendordep_pdu() AVRCP PDU 0x31, company 0x001958 len 0x0005 Oct 12 11:17:41 volumio bluetoothd[24450]: profiles/audio/avrcp.c:handle_vendordep_pdu() AVRCP PDU 0x50, company 0x001958 len 0x0001 Oct 12 11:17:41 volumio volumio[21959]: info: VolumeController::SetAlsaVolume62 Oct 12 11:17:41 volumio volumio[21959]: BT PLUGIN MESSAGE: Volume set to 62 Oct 12 11:17:41 volumio volumio[21959]: info: CoreStateMachine::pushState Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::volumioPushState Oct 12 11:17:41 volumio bluetoothd[24450]: profiles/audio/avrcp.c:avrcp_now_playing_changed() NowPlaying changed Oct 12 11:17:41 volumio volumio[21959]: info: MRS: Pushing multiroomSync output update for this device Oct 12 11:17:41 volumio volumio[21959]: info: MRS: Pushing multiroomSync output Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::volumioGetState Oct 12 11:17:41 volumio systemd[1]: Stopping triggerhappy.service - triggerhappy global hotkey daemon... Oct 12 11:17:41 volumio volumio[21959]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 12 11:17:41 volumio systemd[1]: triggerhappy.service: Deactivated successfully. Oct 12 11:17:41 volumio systemd[1]: Stopped triggerhappy.service - triggerhappy global hotkey daemon. Oct 12 11:17:41 volumio volumio[21959]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 12 11:17:41 volumio volumio[21959]: BT PLUGIN MESSAGE: Duration is 254085 Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::servicePushState Oct 12 11:17:41 volumio volumio[21959]: info: CoreStateMachine::pushState Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::volumioPushState Oct 12 11:17:41 volumio volumio[21959]: info: MRS: Pushing multiroomSync output update for this device Oct 12 11:17:41 volumio volumio[21959]: info: MRS: Pushing multiroomSync output Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::volumioGetState Oct 12 11:17:41 volumio systemd[1]: Starting triggerhappy.service - triggerhappy global hotkey daemon... Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::servicePushState Oct 12 11:17:41 volumio volumio[21959]: info: CoreStateMachine::pushState Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::volumioPushState Oct 12 11:17:41 volumio thd[25103]: Unable to parse trigger line: Oct 12 11:17:41 volumio thd[25103]: Unable to parse trigger line: Oct 12 11:17:41 volumio systemd[1]: Started triggerhappy.service - triggerhappy global hotkey daemon. Oct 12 11:17:41 volumio volumio[21959]: info: MRS: Pushing multiroomSync output update for this device Oct 12 11:17:41 volumio volumio[21959]: info: MRS: Pushing multiroomSync output Oct 12 11:17:41 volumio systemd-logind[683]: Watching system buttons on /dev/input/event2 (一加 Ace 6T (AVRCP)) Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::volumioGetState Oct 12 11:17:41 volumio volumio[21959]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::servicePushState Oct 12 11:17:41 volumio volumio[21959]: info: CoreStateMachine::pushState Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::volumioPushState Oct 12 11:17:41 volumio volumio[21959]: info: MRS: Pushing multiroomSync output update for this device Oct 12 11:17:41 volumio volumio[21959]: info: MRS: Pushing multiroomSync output Oct 12 11:17:41 volumio volumio[21959]: info: CoreCommandRouter::volumioGetState Oct 12 11:17:42 volumio volumio[21959]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 11:17:42 volumio volumio[21959]: Error: connect ECONNREFUSED 185.45.6.57:443 Oct 12 11:17:42 volumio volumio[21959]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 12 11:17:42 volumio volumio[21959]: errno: -111, Oct 12 11:17:42 volumio volumio[21959]: code: 'ECONNREFUSED', Oct 12 11:17:42 volumio volumio[21959]: syscall: 'connect', Oct 12 11:17:42 volumio volumio[21959]: address: '185.45.6.57', Oct 12 11:17:42 volumio volumio[21959]: port: 443 Oct 12 11:17:42 volumio volumio[21959]: } Oct 12 11:17:42 volumio volumio[21959]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 11:17:43 volumio sudo[25118]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 11:16' Oct 12 11:17:43 volumio sudo[25118]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"