-- Logs begin at Fri 2025-06-20 12:47:25 UTC, end at Fri 2025-06-20 18:00:39 UTC. -- Jun 20 17:59:00 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:00 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:01 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:01 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:01 axiomair-888acb root[1176]: [2025/06/20 17:59:01:7322] NOTICE: Sending : 2 Jun 20 17:59:01 axiomair-888acb root[1176]: [2025/06/20 17:59:01:7323] NOTICE: ping Jun 20 17:59:02 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:02 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:03 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:03 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:04 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:04 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:05 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:05 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:06 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:06 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:07 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:07 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:08 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:08 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:09 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:09 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:10 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:10 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:11 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:11 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:11 axiomair-888acb root[1176]: [2025/06/20 17:59:11:8387] NOTICE: Sending : 2 Jun 20 17:59:11 axiomair-888acb root[1176]: [2025/06/20 17:59:11:8388] NOTICE: ping Jun 20 17:59:12 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:12 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:13 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:13 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:14 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:14 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:15 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:15 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:16 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:16 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:17 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:17 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:18 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:18 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:19 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:19 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:20 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:20 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:21 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:21 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:21 axiomair-888acb root[1176]: [2025/06/20 17:59:21:9451] NOTICE: Sending : 2 Jun 20 17:59:21 axiomair-888acb root[1176]: [2025/06/20 17:59:21:9452] NOTICE: ping Jun 20 17:59:22 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:22 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:23 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:23 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:24 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:24 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:25 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:25 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:26 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:26 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:27 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:27 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:28 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:28 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:29 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:29 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:30 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:30 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:31 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:31 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:31 axiomair-888acb root[1176]: 2025-06-20 05:59:31.835944 PM [AirPlay] Control pair-verify ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57149) 1 Jun 20 17:59:31 axiomair-888acb root[1176]: 2025-06-20 05:59:31.836064 PM [AirPlay] pair-verify useHomeKitPairing 1 pairingType 6 Jun 20 17:59:31 axiomair-888acb root[1176]: 2025-06-20 05:59:31.872741 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57149), type 4 Jun 20 17:59:32 axiomair-888acb root[1176]: [2025/06/20 17:59:32:0535] NOTICE: Sending : 2 Jun 20 17:59:32 axiomair-888acb root[1176]: [2025/06/20 17:59:32:0536] NOTICE: ping Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.098582 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57149), type 4 Jun 20 17:59:32 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:32 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.610311 PM [Airtunesd] Received Client IP Update Message Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.610468 PM [Airtunesd] Unsupported session copy property request: rtpSkewPlatformAdjust Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.613873 PM [AirPlay] Updated Bonjour TXT for _airplay._tcp. Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.615873 PM [AirPlay] Updated Bonjour TXT for _raop._tcp. Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.616016 PM [Airtunesd] Unsupported session copy property request: ptpPowerState Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.616112 PM [Airtunesd] Received and Unknown Update Message Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.616448 PM [AirPlay] _GeneralAudioAddIPAddrs: our ptp info: { Jun 20 17:59:32 axiomair-888acb root[1176]: "SupportsClockPortMatchingOverride" : false Jun 20 17:59:32 axiomair-888acb root[1176]: "Addresses" : Jun 20 17:59:32 axiomair-888acb root[1176]: [ Jun 20 17:59:32 axiomair-888acb root[1176]: "192.168.4.72" Jun 20 17:59:32 axiomair-888acb root[1176]: ] Jun 20 17:59:32 axiomair-888acb root[1176]: "ID" : "9291aa14-77bd-492d-9bea-0484f9d126c0" Jun 20 17:59:32 axiomair-888acb root[1176]: } Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.660218 PM [AirPlay] _requestProcessGetParameter:server volume set to 0.0 Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.699531 PM [AirPlay] AirPlay;2.0.4(28.0) master session started from [fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57149, 0/0x0 noErr Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.706288 PM [AirPlay] AirPlayReceiverSessionSetPeers: [ Jun 20 17:59:32 axiomair-888acb root[1176]: "fd8a:4f78:d06d:1:4fc:d1af:b627:9216", Jun 20 17:59:32 axiomair-888acb root[1176]: "fe80::c69:cb8a:99ed:40a", Jun 20 17:59:32 axiomair-888acb root[1176]: "192.168.4.79" Jun 20 17:59:32 axiomair-888acb root[1176]: ] Jun 20 17:59:32 axiomair-888acb root[1176]: on wlan0 Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.735178 PM [AirTunesAvnuClock] PTPClockLaunch: launched PID 18722 Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.935582 PM [AirTunesAvnuClock] PTPClockOpenMsgPort Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.935735 PM [AirTunesAvnuClock] Device at ip address 192.168.4.79 is added into the clock group. Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.944492 PM [Airtunesd] Received and Unknown Update Message Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.944595 PM [AirPlay] ### Command from Client Identifier 'updateMRSupportedCommands' failed: 400/0x190 Bad Request, -6714/0xFFFFE5C6 kNotHandledErr Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.951859 PM [Airtunesd] Received and Unknown Update Message Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.951960 PM [AirPlay] ### Command from Client Identifier 'updateMRSupportedCommands' failed: 400/0x190 Bad Request, -6714/0xFFFFE5C6 kNotHandledErr Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.958885 PM [AirPlay] _requestProcessSetParameterText: dbVolume = -20.0 Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.958973 PM [AirPlay] _requestProcessSetParameterText:server volume set to -20.0 Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.982471 PM [Airtunesd] Received and Unknown Update Message Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.982597 PM [Airtunesd] Received and Unknown Update Message Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.982838 PM [Airtunesd] Received and Unknown Update Message Jun 20 17:59:32 axiomair-888acb root[1176]: 2025-06-20 05:59:32.984092 PM [AirPlay] Main audio setting up ALAC/44100/16/2 for default, input no, loopback no, volume:-20.000000 Jun 20 17:59:32 axiomair-888acb root[1176]: Source Format ID : 616c6163 Jun 20 17:59:32 axiomair-888acb kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Jun 20 17:59:33 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:33 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:34 axiomair-888acb root[1176]: Frames: 256, period time: 5804, buff_size: 524288 Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.008551 PM [AudioStream] ALSA device is not in SND_PCM_STATE_RUNNING or SND_PCM_STATE_DRAINING state in AudioThreadFn loop. It may be okay. Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.024990 PM [AirPlay] _requestProcessSetParameterText: dbVolume = -20.0 Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.025163 PM [AirPlay] Setting volume to dB=-20.000000, linear=0.100000 Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.025215 PM [AirPlay] _requestProcessSetParameterText:server volume set to -20.0 Jun 20 17:59:34 axiomair-888acb root[1176]: [2025/06/20 17:59:34:0584] NOTICE: Sending : 42["volume", 33] Jun 20 17:59:34 axiomair-888acb volumio[502]: info: VolumeController::SetAlsaVolume33 Jun 20 17:59:34 axiomair-888acb volumio[502]: amixer -M set -c 0 "Digital" 33% Jun 20 17:59:34 axiomair-888acb volumio[502]: info: VolumeController::Volume 33 Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CorePlayQueue::getTrack 0 Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:34 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - stop, service - mpd Jun 20 17:59:34 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:34 axiomair-888acb sudo[18735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:34 axiomair-888acb sudo[18735]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:34 axiomair-888acb sudo[18735]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:34 axiomair-888acb sudo[18739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.150318 PM [AirPlay] Flushing receiver complete: flushSeq 16340 flushTS 2186111218 count 0 Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.150469 PM [Airtunesd] Received Play Status Update Message Jun 20 17:59:34 axiomair-888acb root[1176]: [2025/06/20 17:59:34:1505] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Jun 20 17:59:34 axiomair-888acb sudo[18739]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.156157 PM [AirPlay] ProcessPkt Flush Complete flushSeq 16340 flushTS 2186111218 count 0 Seq # 16351 TS 2186115090 Jun 20 17:59:34 axiomair-888acb sudo[18747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:34 axiomair-888acb sudo[18739]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:34 axiomair-888acb sudo[18747]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:34 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false} Jun 20 17:59:34 axiomair-888acb sudo[18747]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jun 20 17:59:34 axiomair-888acb volumio[502]: info: Airplay stopped playing. Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CorePlayQueue::getTrack 0 Jun 20 17:59:34 axiomair-888acb volumio[502]: info: STATE SERVICE {"status":"play","service":"airplay","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true} Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CURRENT POSITION 0 Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState stateService play Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState currentStatus stop Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CorePlayQueue::getTrack 0 Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:34 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - stop, service - mpd Jun 20 17:59:34 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:34 axiomair-888acb sudo[18763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:34 axiomair-888acb sudo[18763]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:34 axiomair-888acb sudo[18763]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:34 axiomair-888acb sudo[18767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:34 axiomair-888acb sudo[18767]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:34 axiomair-888acb sudo[18767]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:34 axiomair-888acb sudo[18776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:34 axiomair-888acb sudo[18776]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:34 axiomair-888acb sudo[18776]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:34 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false} Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.525060 PM [AirPlay] ### Lost packets 16399-16400 (+1, 1 total) Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.525762 PM [AirPlay] ### Misordered packet seq 16400 -> 16399 Jun 20 17:59:34 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:34 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.668129 PM [AirPlay] ### Lost packets 16413-16414 (+1, 2 total) Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.670434 PM [AirPlay] ### Misordered packet seq 16417 -> 16413 Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.819978 PM [AirPlay] SetRateAndAnchorTime inRate 1 rtpTme 2186066647 netTime (timeline=b827ebfffedddf9e secs=1750442374 flags=0) Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.820137 PM [AirPlay] SetRateAndAnchorTime timeline match after #0 tries Jun 20 17:59:34 axiomair-888acb root[1176]: 2025-06-20 05:59:34.820231 PM [Airtunesd] Received Play Status Update Message Jun 20 17:59:34 axiomair-888acb root[1176]: [2025/06/20 17:59:34:8203] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"1"}}] Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jun 20 17:59:34 axiomair-888acb volumio[502]: info: Airplay started streaming Jun 20 17:59:34 axiomair-888acb volumio[502]: info: AIRPLAY: Un-Docking Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:34 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 17:59:34 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:34 axiomair-888acb sudo[18794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:34 axiomair-888acb sudo[18794]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:34 axiomair-888acb sudo[18797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:34 axiomair-888acb sudo[18794]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:34 axiomair-888acb sudo[18797]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:34 axiomair-888acb sudo[18797]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:34 axiomair-888acb sudo[18806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:34 axiomair-888acb sudo[18806]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:34 axiomair-888acb sudo[18806]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:34 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.200917 PM [AirPlay] ### Lost packets 16472-16477 (+5, 7 total) Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.208864 PM [AirPlay] ### Misordered packet seq 16477 -> 16472 Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.210061 PM [AirPlay] ### Misordered packet seq 16477 -> 16473 Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.210161 PM [AirPlay] ### Misordered packet seq 16477 -> 16474 Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.211118 PM [AirPlay] ### Misordered packet seq 16477 -> 16475 Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.211193 PM [AirPlay] ### Misordered packet seq 16477 -> 16476 Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.297406 PM [Airtunesd] Received Meta Data Update Message Jun 20 17:59:35 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:35 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.617639 PM [AirPlay] ### Lost packets 16534-16535 (+1, 8 total) Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.628377 PM [AirPlay] ### Misordered packet seq 16536 -> 16534 Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.726977 PM [AirPlay] ### Lost packets 16540-16541 (+1, 9 total) Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.729021 PM [AirPlay] ### Misordered packet seq 16548 -> 16540 Jun 20 17:59:35 axiomair-888acb root[1176]: 2025-06-20 05:59:35.974720 PM [AirPlay] Concealed 337 unit gap (90846 vs 91183), curr seq 16340 Jun 20 17:59:36 axiomair-888acb root[1176]: 2025-06-20 05:59:36.242115 PM [AirPlay] ### Misordered packet seq 16615 -> 16613 Jun 20 17:59:36 axiomair-888acb root[1176]: 2025-06-20 05:59:36.243656 PM [AirPlay] ### Misordered packet seq 16615 -> 16614 Jun 20 17:59:36 axiomair-888acb root[1176]: 2025-06-20 05:59:36.268622 PM [AirPlay] ### Misordered packet seq 16618 -> 16616 Jun 20 17:59:36 axiomair-888acb root[1176]: 2025-06-20 05:59:36.521141 PM [AirPlay] ### Misordered packet seq 16650 -> 16649 Jun 20 17:59:36 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:36 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:36 axiomair-888acb root[1176]: 2025-06-20 05:59:36.849446 PM [AirPlay] ### Misordered packet seq 16690 -> 16689 Jun 20 17:59:37 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:37 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:37 axiomair-888acb root[1176]: 2025-06-20 05:59:37.658558 PM [AirPlay] ### Lost packets 16790-16791 (+1, 15 total) Jun 20 17:59:37 axiomair-888acb root[1176]: 2025-06-20 05:59:37.658912 PM [AirPlay] ### Misordered packet seq 16791 -> 16790 Jun 20 17:59:38 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:38 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:39 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:39 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:40 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:40 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:41 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:41 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:42 axiomair-888acb root[1176]: [2025/06/20 17:59:42:1650] NOTICE: Sending : 2 Jun 20 17:59:42 axiomair-888acb root[1176]: [2025/06/20 17:59:42:1650] NOTICE: ping Jun 20 17:59:42 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:42 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:43 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:43 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:44 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:44 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:45 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:45 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:46 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:46 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:47 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:47 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:48 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:48 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:49 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:49 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:50 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:50 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:51 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:51 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:52 axiomair-888acb root[1176]: [2025/06/20 17:59:52:2725] NOTICE: Sending : 2 Jun 20 17:59:52 axiomair-888acb root[1176]: [2025/06/20 17:59:52:2725] NOTICE: ping Jun 20 17:59:52 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:52 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:53 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:53 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:54 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:54 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:55 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:55 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:56 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:56 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:57 axiomair-888acb root[1176]: [2025/06/20 17:59:57:2292] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jun 20 17:59:57 axiomair-888acb root[1176]: "artwork_mime_type": "image\/jpeg", Jun 20 17:59:57 axiomair-888acb root[1176]: "artwork_file": "\/tmp\/airplay2.artwork.jpg" Jun 20 17:59:57 axiomair-888acb root[1176]: }}] Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:57 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 17:59:57 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.259949 PM [Airtunesd] Received and Unknown Update Message Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.260083 PM [AirPlay] ### Command from Client Identifier 'updateMRSupportedCommands' failed: 400/0x190 Bad Request, -6714/0xFFFFE5C6 kNotHandledErr Jun 20 17:59:57 axiomair-888acb sudo[18865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.269384 PM [AirPlay] Teardown Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.272985 PM [AudioStream] Requested to quit AudioThreadFn loop. Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:57 axiomair-888acb sudo[18865]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb sudo[18865]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb sudo[18869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:57 axiomair-888acb sudo[18869]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 17:59:57 axiomair-888acb sudo[18869]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb sudo[18875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb sudo[18875]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb sudo[18875]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.374853 PM [AirPlay] Main audio torn down Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.375028 PM [Airtunesd] Received Play Status Update Message Jun 20 17:59:57 axiomair-888acb root[1176]: [2025/06/20 17:59:57:3751] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jun 20 17:59:57 axiomair-888acb volumio[502]: info: Airplay stopped playing. Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:57 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 17:59:57 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.388772 PM [AirPlay] Teardown Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.388900 PM [AirPlay] AirPlay session ended: Dur=24 seconds Reason=0/0x0 noErr Jun 20 17:59:57 axiomair-888acb root[1176]: Glitches: 0%, 1 total, 0 glitchy minute(s) Jun 20 17:59:57 axiomair-888acb root[1176]: Retransmits: 15 sent, 15 received, 0 futile, 0 not found, 0/0/0 ms min/max/avg, 0/0 ms retry min/max Jun 20 17:59:57 axiomair-888acb root[1176]: Packets: 15 lost, 0 unrecovered, 0 late, 5 max burst, 0 big losses, 55% compression Jun 20 17:59:57 axiomair-888acb root[1176]: Time Sync: 1000000000/0/0 ms min/max/avg RTT, 2147483647/-2147483648/0 µS min/max/avg offset, 0 step(s) Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.389101 PM [Airtunesd] Received Play Status Update Message Jun 20 17:59:57 axiomair-888acb root[1176]: [2025/06/20 17:59:57:3891] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.389482 PM [Airtunesd] Received Play Status Update Message Jun 20 17:59:57 axiomair-888acb root[1176]: [2025/06/20 17:59:57:3895] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.390050 PM [AirTunesAvnuClock] Device at ip address 192.168.4.79 is removed from the clock group. Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.390250 PM [AirTunesAvnuClock] AirTunesPTPClock_Finalize Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.390388 PM [AirTunesAvnuClock] AirTunesPTPClock_Finalize: SIGTERM 18722 Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.392187 PM [AirTunesAvnuClock] ptp process 18722 exited with no errors Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.394857 PM [AirPlay] Updated Bonjour TXT for _airplay._tcp. Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.397908 PM [AirPlay] Updated Bonjour TXT for _raop._tcp. Jun 20 17:59:57 axiomair-888acb root[1176]: 2025-06-20 05:59:57.398333 PM [AirPlaySessionManager] Releasing master session:0x6DB04FA8 Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:57 axiomair-888acb sudo[18892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:57 axiomair-888acb sudo[18892]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb sudo[18892]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb sudo[18895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:57 axiomair-888acb sudo[18895]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb sudo[18895]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jun 20 17:59:57 axiomair-888acb volumio[502]: info: Airplay stopped playing. Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:57 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 17:59:57 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 17:59:57 axiomair-888acb sudo[18904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb sudo[18904]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb sudo[18904]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:57 axiomair-888acb sudo[18918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:57 axiomair-888acb sudo[18918]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb sudo[18924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb sudo[18918]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jun 20 17:59:57 axiomair-888acb volumio[502]: info: Airplay stopped playing. Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 17:59:57 axiomair-888acb sudo[18924]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:57 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 17:59:57 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 17:59:57 axiomair-888acb sudo[18924]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb sudo[18932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:57 axiomair-888acb sudo[18932]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb sudo[18932]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb sudo[18941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 17:59:57 axiomair-888acb sudo[18941]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb sudo[18950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb sudo[18941]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb sudo[18950]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 17:59:57 axiomair-888acb sudo[18950]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:57 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:57 axiomair-888acb sudo[18964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 17:59:57 axiomair-888acb sudo[18964]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 17:59:57 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 17:59:57 axiomair-888acb sudo[18964]: pam_unix(sudo:session): session closed for user root Jun 20 17:59:57 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 17:59:57 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 17:59:58 axiomair-888acb root[1176]: 2025-06-20 05:59:58.289931 PM [AirPlay] Control pair-verify ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57155) 1 Jun 20 17:59:58 axiomair-888acb root[1176]: 2025-06-20 05:59:58.290058 PM [AirPlay] pair-verify useHomeKitPairing 1 pairingType 6 Jun 20 17:59:58 axiomair-888acb root[1176]: 2025-06-20 05:59:58.306683 PM [AirPlay] Control pair-verify ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57156) 1 Jun 20 17:59:58 axiomair-888acb root[1176]: 2025-06-20 05:59:58.306853 PM [AirPlay] pair-verify useHomeKitPairing 1 pairingType 6 Jun 20 17:59:58 axiomair-888acb root[1176]: 2025-06-20 05:59:58.314620 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57155), type 4 Jun 20 17:59:58 axiomair-888acb root[1176]: 2025-06-20 05:59:58.439211 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57156), type 4 Jun 20 17:59:58 axiomair-888acb root[1176]: 2025-06-20 05:59:58.439409 PM [AirPlay] Pair-setup server throttling for 1 second(s) Jun 20 17:59:58 axiomair-888acb root[1176]: 2025-06-20 05:59:58.473471 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57155), type 4 Jun 20 17:59:58 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:58 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:58 axiomair-888acb root[1176]: 2025-06-20 05:59:58.927200 PM [AirPlay] AirPlay;2.0.4(28.0) relay session started from [fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57155, 0/0x0 noErr Jun 20 17:59:59 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 17:59:59 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:00 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:00 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:01 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:01 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:02 axiomair-888acb root[1176]: [2025/06/20 18:00:02:3796] NOTICE: Sending : 2 Jun 20 18:00:02 axiomair-888acb root[1176]: [2025/06/20 18:00:02:3797] NOTICE: ping Jun 20 18:00:02 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:02 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:03 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:03 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:04 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:04 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:05 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:05 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:06 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:06 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:07 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:07 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:08 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:08 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:09 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:09 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:10 axiomair-888acb root[1176]: 2025-06-20 06:00:10.478963 PM [AirPlay] Control pair-verify ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57173) 1 Jun 20 18:00:10 axiomair-888acb root[1176]: 2025-06-20 06:00:10.479084 PM [AirPlay] pair-verify useHomeKitPairing 1 pairingType 6 Jun 20 18:00:10 axiomair-888acb root[1176]: 2025-06-20 06:00:10.507182 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57173), type 4 Jun 20 18:00:10 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:10 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:10 axiomair-888acb root[1176]: 2025-06-20 06:00:10.700269 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57173), type 4 Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.131113 PM [Airtunesd] Received Client IP Update Message Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.131228 PM [Airtunesd] Unsupported session copy property request: rtpSkewPlatformAdjust Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.133541 PM [AirPlay] Updated Bonjour TXT for _airplay._tcp. Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.135560 PM [AirPlay] Updated Bonjour TXT for _raop._tcp. Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.135698 PM [Airtunesd] Unsupported session copy property request: ptpPowerState Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.135785 PM [Airtunesd] Received and Unknown Update Message Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.136109 PM [AirPlay] _GeneralAudioAddIPAddrs: our ptp info: { Jun 20 18:00:11 axiomair-888acb root[1176]: "SupportsClockPortMatchingOverride" : false Jun 20 18:00:11 axiomair-888acb root[1176]: "Addresses" : Jun 20 18:00:11 axiomair-888acb root[1176]: [ Jun 20 18:00:11 axiomair-888acb root[1176]: "192.168.4.72" Jun 20 18:00:11 axiomair-888acb root[1176]: ] Jun 20 18:00:11 axiomair-888acb root[1176]: "ID" : "cdeee6d5-791c-46b0-8e54-336d88cae81c" Jun 20 18:00:11 axiomair-888acb root[1176]: } Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.206090 PM [AirPlay] _requestProcessGetParameter:server volume set to 0.0 Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.213262 PM [AirPlay] AirPlay;2.0.4(28.0) master session started from [fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57173, 0/0x0 noErr Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.218600 PM [AirPlay] AirPlayReceiverSessionSetPeers: [ Jun 20 18:00:11 axiomair-888acb root[1176]: "fd8a:4f78:d06d:1:4fc:d1af:b627:9216", Jun 20 18:00:11 axiomair-888acb root[1176]: "fe80::c69:cb8a:99ed:40a", Jun 20 18:00:11 axiomair-888acb root[1176]: "192.168.4.79" Jun 20 18:00:11 axiomair-888acb root[1176]: ] Jun 20 18:00:11 axiomair-888acb root[1176]: on wlan0 Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.234943 PM [AirTunesAvnuClock] PTPClockLaunch: launched PID 19008 Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.435291 PM [AirTunesAvnuClock] PTPClockOpenMsgPort Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.435442 PM [AirTunesAvnuClock] Device at ip address 192.168.4.79 is added into the clock group. Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.441524 PM [Airtunesd] Received and Unknown Update Message Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.441627 PM [AirPlay] ### Command from Client Identifier 'updateMRSupportedCommands' failed: 400/0x190 Bad Request, -6714/0xFFFFE5C6 kNotHandledErr Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.448655 PM [AirPlay] _requestProcessSetParameterText: dbVolume = -20.0 Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.448755 PM [AirPlay] _requestProcessSetParameterText:server volume set to -20.0 Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.460999 PM [Airtunesd] Received and Unknown Update Message Jun 20 18:00:11 axiomair-888acb root[1176]: 2025-06-20 06:00:11.461104 PM [AirPlay] ### Command from Client Identifier 'updateMRSupportedCommands' failed: 400/0x190 Bad Request, -6714/0xFFFFE5C6 kNotHandledErr Jun 20 18:00:11 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:11 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:12 axiomair-888acb root[1176]: [2025/06/20 18:00:12:4863] NOTICE: Sending : 2 Jun 20 18:00:12 axiomair-888acb root[1176]: [2025/06/20 18:00:12:4864] NOTICE: ping Jun 20 18:00:12 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:12 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:13 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:13 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:14 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:14 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:15 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:15 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:16 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:16 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:17 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:17 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.238815 PM [AirPlay] Teardown Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.238979 PM [AirPlay] AirPlay session ended: Dur=7 seconds Reason=0/0x0 noErr Jun 20 18:00:18 axiomair-888acb root[1176]: Glitches: 0%, 0 total, 0 glitchy minute(s) Jun 20 18:00:18 axiomair-888acb root[1176]: Retransmits: 0 sent, 0 received, 0 futile, 0 not found, 0/0/0 ms min/max/avg, 0/0 ms retry min/max Jun 20 18:00:18 axiomair-888acb root[1176]: Packets: 15 lost, 0 unrecovered, 0 late, 0 max burst, 0 big losses, 0% compression Jun 20 18:00:18 axiomair-888acb root[1176]: Time Sync: 1000000000/0/0 ms min/max/avg RTT, 2147483647/-2147483648/0 µS min/max/avg offset, 0 step(s) Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.239229 PM [Airtunesd] Received Play Status Update Message Jun 20 18:00:18 axiomair-888acb root[1176]: [2025/06/20 18:00:18:2393] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.239406 PM [Airtunesd] Received Play Status Update Message Jun 20 18:00:18 axiomair-888acb root[1176]: [2025/06/20 18:00:18:2396] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.239908 PM [AirPlay] AirPlay remote control session ended: Dur=19 seconds Reason=0/0x0 noErr Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.240230 PM [AirTunesAvnuClock] Device at ip address 192.168.4.79 is removed from the clock group. Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.240394 PM [AirTunesAvnuClock] AirTunesPTPClock_Finalize Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.240538 PM [AirTunesAvnuClock] AirTunesPTPClock_Finalize: SIGTERM 19008 Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.242728 PM [AirTunesAvnuClock] ptp process 19008 exited with no errors Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.245506 PM [AirPlay] Updated Bonjour TXT for _airplay._tcp. Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.248099 PM [AirPlay] Updated Bonjour TXT for _raop._tcp. Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.248235 PM [AirPlaySessionManager] Releasing master session:0x6DC0ACE0 Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jun 20 18:00:18 axiomair-888acb volumio[502]: info: Airplay stopped playing. Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:18 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 18:00:18 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.256223 PM [AirPlay] AirPlay remote control session ended: Dur=19 seconds Reason=0/0x0 noErr Jun 20 18:00:18 axiomair-888acb root[1176]: 2025-06-20 06:00:18.256590 PM [AirPlaySessionManager] Removing remote session:0x6DB0D3B0 Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:18 axiomair-888acb sudo[19030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:18 axiomair-888acb sudo[19030]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:18 axiomair-888acb sudo[19030]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:18 axiomair-888acb sudo[19035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:18 axiomair-888acb sudo[19035]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:18 axiomair-888acb sudo[19035]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:18 axiomair-888acb sudo[19042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jun 20 18:00:18 axiomair-888acb volumio[502]: info: Airplay stopped playing. Jun 20 18:00:18 axiomair-888acb sudo[19042]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:18 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 18:00:18 axiomair-888acb sudo[19042]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:18 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:18 axiomair-888acb sudo[19057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:18 axiomair-888acb sudo[19057]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:18 axiomair-888acb sudo[19057]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:18 axiomair-888acb sudo[19061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:18 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:18 axiomair-888acb sudo[19061]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:18 axiomair-888acb sudo[19068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:18 axiomair-888acb sudo[19061]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:18 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 18:00:18 axiomair-888acb sudo[19068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:18 axiomair-888acb sudo[19068]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:18 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 18:00:18 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:18 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:19 axiomair-888acb root[1176]: 2025-06-20 06:00:19.597718 PM [AirPlay] Control pair-verify ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57176) 1 Jun 20 18:00:19 axiomair-888acb root[1176]: 2025-06-20 06:00:19.597871 PM [AirPlay] pair-verify useHomeKitPairing 1 pairingType 6 Jun 20 18:00:19 axiomair-888acb root[1176]: 2025-06-20 06:00:19.603177 PM [AirPlay] Control pair-verify ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57177) 1 Jun 20 18:00:19 axiomair-888acb root[1176]: 2025-06-20 06:00:19.603258 PM [AirPlay] pair-verify useHomeKitPairing 1 pairingType 6 Jun 20 18:00:19 axiomair-888acb root[1176]: 2025-06-20 06:00:19.638378 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57177), type 4 Jun 20 18:00:19 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:19 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:19 axiomair-888acb root[1176]: 2025-06-20 06:00:19.768384 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57176), type 4 Jun 20 18:00:19 axiomair-888acb root[1176]: 2025-06-20 06:00:19.768606 PM [AirPlay] Pair-setup server throttling for 1 second(s) Jun 20 18:00:19 axiomair-888acb root[1176]: 2025-06-20 06:00:19.842034 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57177), type 4 Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.299216 PM [Airtunesd] Received Client IP Update Message Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.299337 PM [Airtunesd] Unsupported session copy property request: rtpSkewPlatformAdjust Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.302835 PM [AirPlay] Updated Bonjour TXT for _airplay._tcp. Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.305543 PM [AirPlay] Updated Bonjour TXT for _raop._tcp. Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.305672 PM [Airtunesd] Unsupported session copy property request: ptpPowerState Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.305760 PM [Airtunesd] Received and Unknown Update Message Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.306104 PM [AirPlay] _GeneralAudioAddIPAddrs: our ptp info: { Jun 20 18:00:20 axiomair-888acb root[1176]: "SupportsClockPortMatchingOverride" : false Jun 20 18:00:20 axiomair-888acb root[1176]: "Addresses" : Jun 20 18:00:20 axiomair-888acb root[1176]: [ Jun 20 18:00:20 axiomair-888acb root[1176]: "192.168.4.72" Jun 20 18:00:20 axiomair-888acb root[1176]: ] Jun 20 18:00:20 axiomair-888acb root[1176]: "ID" : "8a34ac94-cbff-4575-be5a-55b7bab67fec" Jun 20 18:00:20 axiomair-888acb root[1176]: } Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.356623 PM [AirPlay] _requestProcessGetParameter:server volume set to 0.0 Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.364196 PM [AirPlay] AirPlay;2.0.4(28.0) master session started from [fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57177, 0/0x0 noErr Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.370593 PM [AirPlay] AirPlayReceiverSessionSetPeers: [ Jun 20 18:00:20 axiomair-888acb root[1176]: "fd8a:4f78:d06d:1:4fc:d1af:b627:9216", Jun 20 18:00:20 axiomair-888acb root[1176]: "fe80::c69:cb8a:99ed:40a", Jun 20 18:00:20 axiomair-888acb root[1176]: "192.168.4.79" Jun 20 18:00:20 axiomair-888acb root[1176]: ] Jun 20 18:00:20 axiomair-888acb root[1176]: on wlan0 Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.387471 PM [AirTunesAvnuClock] PTPClockLaunch: launched PID 19089 Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.587813 PM [AirTunesAvnuClock] PTPClockOpenMsgPort Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.587975 PM [AirTunesAvnuClock] Device at ip address 192.168.4.79 is added into the clock group. Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.602474 PM [Airtunesd] Received and Unknown Update Message Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.602610 PM [AirPlay] ### Command from Client Identifier 'updateMRSupportedCommands' failed: 400/0x190 Bad Request, -6714/0xFFFFE5C6 kNotHandledErr Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.619545 PM [AirPlay] _requestProcessSetParameterText: dbVolume = -20.0 Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.620530 PM [AirPlay] _requestProcessSetParameterText:server volume set to -20.0 Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.629385 PM [Airtunesd] Received and Unknown Update Message Jun 20 18:00:20 axiomair-888acb root[1176]: 2025-06-20 06:00:20.630376 PM [AirPlay] ### Command from Client Identifier 'updateMRSupportedCommands' failed: 400/0x190 Bad Request, -6714/0xFFFFE5C6 kNotHandledErr Jun 20 18:00:20 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:20 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:21 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:21 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:22 axiomair-888acb root[1176]: [2025/06/20 18:00:22:5934] NOTICE: Sending : 2 Jun 20 18:00:22 axiomair-888acb root[1176]: [2025/06/20 18:00:22:5935] NOTICE: ping Jun 20 18:00:22 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:22 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:23 axiomair-888acb root[1176]: 2025-06-20 06:00:23.562792 PM [AirPlay] Control pair-verify ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57179) 1 Jun 20 18:00:23 axiomair-888acb root[1176]: 2025-06-20 06:00:23.562913 PM [AirPlay] pair-verify useHomeKitPairing 1 pairingType 6 Jun 20 18:00:23 axiomair-888acb root[1176]: 2025-06-20 06:00:23.598049 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57179), type 4 Jun 20 18:00:23 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:23 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:23 axiomair-888acb root[1176]: 2025-06-20 06:00:23.796447 PM [AirPlay] Control pair-setup HK ([fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57179), type 4 Jun 20 18:00:24 axiomair-888acb root[1176]: 2025-06-20 06:00:24.260388 PM [AirPlay] AirPlay;2.0.4(28.0) relay session started from [fd8a:4f78:d06d:1:4fc:d1af:b627:9216]:57179, 0/0x0 noErr Jun 20 18:00:24 axiomair-888acb root[1176]: 2025-06-20 06:00:24.308287 PM [AirPlay] RCS creation status: 0 Jun 20 18:00:24 axiomair-888acb root[1176]: 2025-06-20 06:00:24.309223 PM [AirPlay] RCS creation response: {} Jun 20 18:00:24 axiomair-888acb root[1176]: Jun 20 18:00:24 axiomair-888acb root[1176]: 2025-06-20 06:00:24.310453 PM [AirPlay] Signalling complete Jun 20 18:00:24 axiomair-888acb root[1176]: 2025-06-20 06:00:24.311064 PM [AirPlay] RCS creation status: 0 Jun 20 18:00:24 axiomair-888acb root[1176]: 2025-06-20 06:00:24.311138 PM [AirPlay] RCS setup successful Jun 20 18:00:24 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:24 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:25 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:25 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:26 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:26 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:27 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:27 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:28 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:28 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:29 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:29 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:30 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:30 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:31 axiomair-888acb volumio[9749]: [Vollibrespot] : Os { code: 104, kind: ConnectionReset, message: "Connection reset by peer" } Jun 20 18:00:31 axiomair-888acb volumio[9749]: [Vollibrespot] : Connecting to AP "ap-gue1.spotify.com:4070" Jun 20 18:00:31 axiomair-888acb volumio[9749]: thread 'main' panicked at 'called `Result::unwrap()` on an `Err` value: Os { code: 111, kind: ConnectionRefused, message: "Connection refused" }', libcore/result.rs:1009:5 Jun 20 18:00:31 axiomair-888acb volumio[9749]: stack backtrace: Jun 20 18:00:31 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:31 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:31 axiomair-888acb volumio[9749]: 0: 0x9cec4f - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3608b871673a8803 Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 1: 0x9be547 - std::sys_common::backtrace::print::hef947be8cf8e8f55 Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/sys_common/backtrace.rs:71 Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/sys_common/backtrace.rs:59 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 2: 0x9bc083 - std::panicking::default_hook::{{closure}}::haac47ed356699ffe Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/panicking.rs:211 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 3: 0x9bbcfb - std::panicking::default_hook::h95ba73384225983b Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/panicking.rs:227 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 4: 0x9bc7ab - std::panicking::rust_panic_with_hook::ha1106c0ce43cea72 Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/panicking.rs:477 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 5: 0x9bc36f - std::panicking::continue_panic_fmt::h875c7946721c05c9 Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/panicking.rs:391 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 6: 0x9bc257 - rust_begin_unwind Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/panicking.rs:326 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 7: 0xa0cb43 - core::panicking::panic_fmt::h429a06507aba9228 Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libcore/panicking.rs:77 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 8: 0x51b3bf - core::result::unwrap_failed::hed968dfd37ddc0a3 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 9: 0x50b1d3 - ::poll::h8de885f8b6bf28df Jun 20 18:00:31 axiomair-888acb volumio[9749]: 10: 0x52d4fb - futures::task_impl::std::set::h3a231d6da27c56c1 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 11: 0x515b1b - as futures::future::Future>::poll::hc0350974eb54f7ad Jun 20 18:00:31 axiomair-888acb volumio[9749]: 12: 0x52d057 - futures::task_impl::std::set::h0db44df5c700aa4f Jun 20 18:00:31 axiomair-888acb volumio[9749]: 13: 0x517ed7 - >::with::ha1273ecb6d30dba0 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 14: 0x5036d7 - >::block_on::hf53fa7227aee9d56 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 15: 0x5185d7 - >::with::hf91e923a09439449 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 16: 0x5173df - >::with::h3da296c6003abc58 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 17: 0x517d3f - >::with::h9880996ad7a77c2d Jun 20 18:00:31 axiomair-888acb volumio[9749]: 18: 0x52594b - >::set::h60c9c58b92fafac6 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 19: 0x51d0b3 - tokio_core::reactor::Core::run::hdd5b409087e686c0 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 20: 0x50d61b - vollibrespot::main::hff5c7bba125530f5 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 21: 0x51e147 - std::rt::lang_start::{{closure}}::h209c228e7daff9ce Jun 20 18:00:31 axiomair-888acb volumio[9749]: 22: 0x9bc1cf - std::panicking::try::do_call::haa4d884de44899fd Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/rt.rs:59 Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/panicking.rs:310 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 23: 0x9d7c0f - __rust_maybe_catch_panic Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libpanic_unwind/lib.rs:103 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 24: 0x9bb217 - std::panic::catch_unwind::h90512a021818b18b Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/panicking.rs:289 Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/panic.rs:392 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 25: 0x9b9bd3 - std::rt::lang_start_internal::h2c5a86fd7f2a32eb Jun 20 18:00:31 axiomair-888acb volumio[9749]: at libstd/rt.rs:58 Jun 20 18:00:31 axiomair-888acb volumio[9749]: 26: 0x50e46f - main Jun 20 18:00:31 axiomair-888acb volumio[9749]: 27: 0x76d28677 - __libc_start_main Jun 20 18:00:31 axiomair-888acb volumio[9749]: [Vollibrespot] : Shutting down MetaPipe ... Some(JoinHandle { .. }) Jun 20 18:00:31 axiomair-888acb volumio[9749]: [Vollibrespot] : Session no longer valid, shutting down MetaPipe Jun 20 18:00:31 axiomair-888acb volumio[9749]: [Vollibrespot] : Closed MetaPipe thread Jun 20 18:00:31 axiomair-888acb systemd[1]: volspotconnect2.service: Main process exited, code=exited, status=101/n/a Jun 20 18:00:31 axiomair-888acb systemd[1]: volspotconnect2.service: Unit entered failed state. Jun 20 18:00:31 axiomair-888acb systemd[1]: volspotconnect2.service: Failed with result 'exit-code'. Jun 20 18:00:32 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:32 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:32 axiomair-888acb root[1176]: [2025/06/20 18:00:32:7005] NOTICE: Sending : 2 Jun 20 18:00:32 axiomair-888acb root[1176]: [2025/06/20 18:00:32:7005] NOTICE: ping Jun 20 18:00:33 axiomair-888acb root[1176]: 2025-06-20 06:00:33.351092 PM [Airtunesd] Received and Unknown Update Message Jun 20 18:00:33 axiomair-888acb root[1176]: 2025-06-20 06:00:33.351246 PM [Airtunesd] Received and Unknown Update Message Jun 20 18:00:33 axiomair-888acb root[1176]: 2025-06-20 06:00:33.351463 PM [Airtunesd] Received and Unknown Update Message Jun 20 18:00:33 axiomair-888acb root[1176]: 2025-06-20 06:00:33.352508 PM [AirPlay] Main audio setting up ALAC/44100/16/2 for default, input no, loopback no, volume:-20.000000 Jun 20 18:00:33 axiomair-888acb root[1176]: Shutting down audtio thread Jun 20 18:00:33 axiomair-888acb root[1176]: Audio Stream shutdown complete Jun 20 18:00:33 axiomair-888acb root[1176]: Entering drain phase.... Jun 20 18:00:33 axiomair-888acb root[1176]: Entering drop phase.... Jun 20 18:00:33 axiomair-888acb root[1176]: Entering free phase.... Jun 20 18:00:33 axiomair-888acb root[1176]: PCM name: 'volume' Jun 20 18:00:33 axiomair-888acb root[1176]: PCM state: OPEN Jun 20 18:00:33 axiomair-888acb root[1176]: Closing PCM Handle. Jun 20 18:00:33 axiomair-888acb root[1176]: PCM Released. Jun 20 18:00:33 axiomair-888acb root[1176]: >>>>> In Audio Finalize Jun 20 18:00:33 axiomair-888acb root[1176]: Shutting down audtio thread Jun 20 18:00:33 axiomair-888acb root[1176]: Audio Stream shutdown complete Jun 20 18:00:33 axiomair-888acb root[1176]: Source Format ID : 616c6163 Jun 20 18:00:33 axiomair-888acb kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Jun 20 18:00:33 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:33 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:33 axiomair-888acb systemd[1]: volspotconnect2.service: Service hold-off time over, scheduling restart. Jun 20 18:00:33 axiomair-888acb systemd[1]: Stopped Volspotconnect2 Daemon. Jun 20 18:00:33 axiomair-888acb systemd[1]: Started Volspotconnect2 Daemon. Jun 20 18:00:34 axiomair-888acb volumio[19130]: vollibrespot v0.1.3 48346b7 2019-02-25 (librespot 57c9ab5 2019-02-22) -- Built On 2019-02-25 Jun 20 18:00:34 axiomair-888acb volumio[19130]: [Vollibrespot] : Connecting to AP "ap-gue1.spotify.com:4070" Jun 20 18:00:34 axiomair-888acb root[1176]: Frames: 256, period time: 5804, buff_size: 524288 Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.373650 PM [AudioStream] ALSA device is not in SND_PCM_STATE_RUNNING or SND_PCM_STATE_DRAINING state in AudioThreadFn loop. It may be okay. Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.383310 PM [AirPlay] SetRateAndAnchorTime inRate 1 rtpTme 1281688008 netTime (timeline=b827ebfffedddf9e secs=1750442434 flags=0) Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.383432 PM [AirPlay] SetRateAndAnchorTime timeline match after #0 tries Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.383509 PM [Airtunesd] Received Play Status Update Message Jun 20 18:00:34 axiomair-888acb root[1176]: [2025/06/20 18:00:34:3835] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"1"}}] Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jun 20 18:00:34 axiomair-888acb volumio[502]: info: Airplay started streaming Jun 20 18:00:34 axiomair-888acb volumio[502]: info: AIRPLAY: Un-Docking Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.392742 PM [AirPlay] _requestProcessSetParameterText: dbVolume = -20.0 Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.392934 PM [AirPlay] Setting volume to dB=-20.000000, linear=0.100000 Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.393006 PM [AirPlay] _requestProcessSetParameterText:server volume set to -20.0 Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:34 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 18:00:34 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.421861 PM [AirPlay] Flushing receiver complete: flushSeq 40714 flushTS 1281767674 count 0 Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.423157 PM [Airtunesd] Received Play Status Update Message Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:34 axiomair-888acb root[1176]: [2025/06/20 18:00:34:4269] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"0"}}] Jun 20 18:00:34 axiomair-888acb sudo[19141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.440362 PM [AirPlay] ProcessPkt Flush Complete flushSeq 40714 flushTS 1281767674 count 0 Seq # 40716 TS 1281768378 Jun 20 18:00:34 axiomair-888acb sudo[19141]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb sudo[19141]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:34 axiomair-888acb sudo[19145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb sudo[19145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jun 20 18:00:34 axiomair-888acb volumio[502]: info: Airplay stopped playing. Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:34 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 18:00:34 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 18:00:34 axiomair-888acb sudo[19150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb sudo[19145]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb sudo[19150]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb volumio[19130]: [Vollibrespot] : Authenticated as "1213862406" ! Jun 20 18:00:34 axiomair-888acb volumio[19130]: [Vollibrespot] : Using alsa sink Jun 20 18:00:34 axiomair-888acb volumio[19130]: [Vollibrespot] : Country: "US" Jun 20 18:00:34 axiomair-888acb volumio[19130]: [Vollibrespot] : Metadata pipe established Jun 20 18:00:34 axiomair-888acb sudo[19150]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:34 axiomair-888acb sudo[19168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:34 axiomair-888acb sudo[19168]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb sudo[19174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:34 axiomair-888acb sudo[19174]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb sudo[19168]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb sudo[19174]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb sudo[19178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 18:00:34 axiomair-888acb sudo[19178]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.580612 PM [AirPlay] ### Lost packets 40735-40736 (+1, 1 total) Jun 20 18:00:34 axiomair-888acb sudo[19178]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.589188 PM [AirPlay] ### Misordered packet seq 40736 -> 40735 Jun 20 18:00:34 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 18:00:34 axiomair-888acb volumio[502]: [SpotifyConnect] Volume: Sp:29.999237048905165 Volumio: 30 Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:34 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 18:00:34 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:34 axiomair-888acb sudo[19198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb sudo[19198]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:34 axiomair-888acb sudo[19198]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:34 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:34 axiomair-888acb sudo[19203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb sudo[19208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb sudo[19203]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb sudo[19208]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 18:00:34 axiomair-888acb sudo[19203]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb sudo[19208]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.811690 PM [AirPlay] ### Lost packets 40763-40764 (+1, 2 total) Jun 20 18:00:34 axiomair-888acb root[1176]: 2025-06-20 06:00:34.812322 PM [AirPlay] ### Misordered packet seq 40764 -> 40763 Jun 20 18:00:34 axiomair-888acb volumio[502]: info: VolumeController::SetAlsaVolume19660 Jun 20 18:00:34 axiomair-888acb volumio[502]: amixer -M set -c 0 "Digital" 29.999237048905165% Jun 20 18:00:34 axiomair-888acb volumio[502]: info: VolumeController::Volume 29.999237048905165 Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:34 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 18:00:34 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:34 axiomair-888acb sudo[19228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb sudo[19228]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:34 axiomair-888acb sudo[19228]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb sudo[19232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb sudo[19232]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:34 axiomair-888acb sudo[19232]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:34 axiomair-888acb sudo[19241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:34 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 18:00:34 axiomair-888acb sudo[19241]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:34 axiomair-888acb sudo[19241]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.161818 PM [AirPlay] ### Lost packets 40807-40809 (+2, 4 total) Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.162549 PM [AirPlay] ### Misordered packet seq 40809 -> 40807 Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.162742 PM [AirPlay] ### Misordered packet seq 40809 -> 40808 Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.385292 PM [AirPlay] SetRateAndAnchorTime inRate 1 rtpTme 1281732193 netTime (timeline=b827ebfffedddf9e secs=1750442435 flags=0) Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.385423 PM [AirPlay] SetRateAndAnchorTime timeline match after #0 tries Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.385500 PM [Airtunesd] Received Play Status Update Message Jun 20 18:00:35 axiomair-888acb root[1176]: [2025/06/20 18:00:35:3855] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"1"}}] Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jun 20 18:00:35 axiomair-888acb volumio[502]: info: Airplay started streaming Jun 20 18:00:35 axiomair-888acb volumio[502]: info: AIRPLAY: Un-Docking Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:35 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 18:00:35 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:35 axiomair-888acb sudo[19257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:35 axiomair-888acb sudo[19257]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:35 axiomair-888acb sudo[19260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:35 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:35 axiomair-888acb sudo[19257]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:35 axiomair-888acb sudo[19260]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:35 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 18:00:35 axiomair-888acb sudo[19260]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:35 axiomair-888acb sudo[19269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:35 axiomair-888acb sudo[19269]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:35 axiomair-888acb sudo[19269]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:35 axiomair-888acb volumio[19130]: [Vollibrespot] : SessionActive! Jun 20 18:00:35 axiomair-888acb volumio[502]: [SpotifyConnect] Connect Session is active! Jun 20 18:00:35 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:35 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:35 axiomair-888acb volumio[19130]: [Vollibrespot] : Loading track "Don't Follow" with Spotify URI "spotify:track:0B1WA7zfGM8qfckO0KN6Ev" Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.730092 PM [AirPlay] ### Lost packets 40875-40876 (+1, 5 total) Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.745402 PM [Airtunesd] Received Meta Data Update Message Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.823048 PM [AirPlay] ### Misordered packet seq 40890 -> 40884 Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.823203 PM [AirPlay] ### Misordered packet seq 40890 -> 40885 Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.823253 PM [AirPlay] ### Misordered packet seq 40890 -> 40886 Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.879981 PM [AirPlay] ### Misordered packet seq 40896 -> 40892 Jun 20 18:00:35 axiomair-888acb root[1176]: 2025-06-20 06:00:35.880157 PM [AirPlay] ### Misordered packet seq 40896 -> 40893 Jun 20 18:00:36 axiomair-888acb volumio[502]: [SpotifyConnect] Pushing metadata Vollibrespot: false Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioGetState Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:36 axiomair-888acb volumio[502]: [SpotifyConnect] Currently active: airplay Jun 20 18:00:36 axiomair-888acb volumio[502]: [SpotifyConnect] Pushing new state :: false Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreCommandRouter::servicePushState Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CorePlayQueue::getTrack 0 Jun 20 18:00:36 axiomair-888acb volumio[502]: info: STATE SERVICE {"status":"pause","service":"volspotconnect2","title":"Don't Follow","artist":"Casper McWade, Cody Jinks","album":"Unraveled","albumart":"https://i.scdn.co/image/ab67616d0000b27317f794338e7a6e6d6a65a036","uri":"spotify:track:0B1WA7zfGM8qfckO0KN6Ev","trackType":"spotify","seek":0,"duration":235,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"stream":false} Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CURRENT POSITION 0 Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState stateService pause Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreStateMachine::syncState currentStatus play Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreStateMachine::pushState Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioPushState Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:36 axiomair-888acb volumio[502]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jun 20 18:00:36 axiomair-888acb volumio[502]: info: interfaceApi::pushState Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:36 axiomair-888acb sudo[19286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jun 20 18:00:36 axiomair-888acb sudo[19286]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:36 axiomair-888acb sudo[19286]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:36 axiomair-888acb sudo[19291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:36 axiomair-888acb volumio[502]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 18:00:36 axiomair-888acb sudo[19291]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:36 axiomair-888acb sudo[19298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 18:00:36 axiomair-888acb root[1176]: 2025-06-20 06:00:36.232163 PM [AirPlay] ### Misordered packet seq 40934 -> 40932 Jun 20 18:00:36 axiomair-888acb sudo[19291]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:36 axiomair-888acb sudo[19298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:36 axiomair-888acb volumio[502]: [SpotifyConnect] Token: Jun 20 18:00:36 axiomair-888acb sudo[19298]: pam_unix(sudo:session): session closed for user root Jun 20 18:00:36 axiomair-888acb volumio[502]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jun 20 18:00:36 axiomair-888acb root[1176]: 2025-06-20 06:00:36.339806 PM [AirPlay] Concealed 59 unit gap (90846 vs 90905), curr seq 40714 Jun 20 18:00:36 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:36 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:36 axiomair-888acb root[1176]: 2025-06-20 06:00:36.786550 PM [AirPlay] ### Misordered packet seq 41012 -> 41010 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.203805 PM [AirPlay] ### Misordered packet seq 41065 -> 41064 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.329368 PM [AirPlay] ### Misordered packet seq 41072 -> 41066 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.329634 PM [AirPlay] ### Misordered packet seq 41072 -> 41067 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.383848 PM [AirPlay] ### Misordered packet seq 41078 -> 41068 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.384507 PM [AirPlay] ### Misordered packet seq 41078 -> 41069 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.384861 PM [AirPlay] ### Misordered packet seq 41078 -> 41070 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.391610 PM [AirPlay] ### Misordered packet seq 41078 -> 41071 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.392139 PM [AirPlay] ### Misordered packet seq 41078 -> 41073 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.397403 PM [AirPlay] ### Misordered packet seq 41078 -> 41074 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.397651 PM [AirPlay] ### Misordered packet seq 41078 -> 41075 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.399694 PM [AirPlay] ### Misordered packet seq 41078 -> 41077 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.621115 PM [AirPlay] ### Lost packets 41112-41117 (+5, 29 total) Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.624615 PM [AirPlay] ### Misordered packet seq 41117 -> 41112 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.625342 PM [AirPlay] ### Misordered packet seq 41117 -> 41113 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.626189 PM [AirPlay] ### Misordered packet seq 41117 -> 41114 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.631650 PM [AirPlay] ### Misordered packet seq 41117 -> 41115 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.632788 PM [AirPlay] ### Misordered packet seq 41117 -> 41116 Jun 20 18:00:37 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:37 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.728440 PM [AirPlay] ### Lost packets 41123-41127 (+4, 33 total) Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.775897 PM [AirPlay] ### Misordered packet seq 41131 -> 41123 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.776087 PM [AirPlay] ### Misordered packet seq 41131 -> 41124 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.776157 PM [AirPlay] ### Misordered packet seq 41131 -> 41125 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.776203 PM [AirPlay] ### Misordered packet seq 41131 -> 41126 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.808890 PM [AirPlay] ### Lost packets 41138-41139 (+1, 34 total) Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.862566 PM [AirPlay] ### Lost packets 41140-41142 (+2, 36 total) Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.872661 PM [AirPlay] ### Lost packets 41143-41144 (+1, 37 total) Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.929064 PM [AirPlay] ### Misordered packet seq 41155 -> 41138 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.929459 PM [AirPlay] ### Misordered packet seq 41155 -> 41148 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.929704 PM [AirPlay] ### Misordered packet seq 41155 -> 41152 Jun 20 18:00:37 axiomair-888acb root[1176]: 2025-06-20 06:00:37.946925 PM [AirPlay] ### Misordered packet seq 41158 -> 41157 Jun 20 18:00:38 axiomair-888acb root[1176]: 2025-06-20 06:00:38.212191 PM [AirPlay] ### Misordered packet seq 41189 -> 41188 Jun 20 18:00:38 axiomair-888acb volumio[19130]: [Vollibrespot] : Track "Don't Follow" loaded Jun 20 18:00:38 axiomair-888acb volumio[19130]: [Vollibrespot] : Alsa error PCM open ALSA function 'snd_pcm_open' failed with error 'EBUSY: Device or resource busy' Jun 20 18:00:38 axiomair-888acb volumio[19130]: [Vollibrespot] : Could not start audio: Alsa error: PCM open failed Jun 20 18:00:38 axiomair-888acb volumio[19130]: [Vollibrespot] : Alsa error PCM open ALSA function 'snd_pcm_open' failed with error 'EBUSY: Device or resource busy' Jun 20 18:00:38 axiomair-888acb volumio[19130]: [Vollibrespot] : Could not start audio: Alsa error: PCM open failed Jun 20 18:00:38 axiomair-888acb volumio[502]: [SpotifyConnect] Device is active! Jun 20 18:00:38 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioGetState Jun 20 18:00:38 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:38 axiomair-888acb volumio[502]: [SpotifyConnect] Currently active: airplay Jun 20 18:00:38 axiomair-888acb volumio[502]: [SpotifyConnect] Stopping currently active service Jun 20 18:00:38 axiomair-888acb volumio[502]: info: CoreCommandRouter::volumioStop Jun 20 18:00:38 axiomair-888acb volumio[502]: info: CoreStateMachine::getState Jun 20 18:00:38 axiomair-888acb volumio[502]: info: VOLUMIOSTOP: service stopped - airplay Jun 20 18:00:38 axiomair-888acb volumio[502]: info: CoreStateMachine::stop Jun 20 18:00:38 axiomair-888acb volumio[502]: info: CoreStateMachine::serviceStop Jun 20 18:00:38 axiomair-888acb volumio[502]: info: Received STOP, but no service to execute it Jun 20 18:00:38 axiomair-888acb volumio[502]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 18:00:38 axiomair-888acb volumio[502]: TypeError: Cannot read property 'then' of undefined Jun 20 18:00:38 axiomair-888acb volumio[502]: at SpotConnEvents. (/volumio/app/plugins/music_service/volspotconnect2/index.js:148:23) Jun 20 18:00:38 axiomair-888acb volumio[502]: at emitOne (events.js:116:13) Jun 20 18:00:38 axiomair-888acb volumio[502]: at SpotConnEvents.emit (events.js:211:7) Jun 20 18:00:38 axiomair-888acb volumio[502]: at SpotConnEvents.parseData (/volumio/app/plugins/music_service/volspotconnect2/SpotConnController.js:48:16) Jun 20 18:00:38 axiomair-888acb volumio[502]: at Socket.SpotConnEvents._udpsource.on.msg (/volumio/app/plugins/music_service/volspotconnect2/SpotConnController.js:15:12) Jun 20 18:00:38 axiomair-888acb volumio[502]: at emitTwo (events.js:126:13) Jun 20 18:00:38 axiomair-888acb volumio[502]: at Socket.emit (events.js:214:7) Jun 20 18:00:38 axiomair-888acb volumio[502]: at UDP.onMessage [as onmessage] (dgram.js:659:8) Jun 20 18:00:38 axiomair-888acb volumio[502]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 18:00:38 axiomair-888acb root[1176]: 2025-06-20 06:00:38.275460 PM [AirPlay] ### Misordered packet seq 41198 -> 41197 Jun 20 18:00:38 axiomair-888acb root[1176]: 2025-06-20 06:00:38.295035 PM [AirPlay] ### Misordered packet seq 41201 -> 41200 Jun 20 18:00:38 axiomair-888acb root[1176]: 2025-06-20 06:00:38.441997 PM [AirPlay] ### Misordered packet seq 41215 -> 41211 Jun 20 18:00:38 axiomair-888acb root[1176]: 2025-06-20 06:00:38.442664 PM [AirPlay] ### Misordered packet seq 41215 -> 41212 Jun 20 18:00:38 axiomair-888acb root[1176]: 2025-06-20 06:00:38.445777 PM [AirPlay] ### Misordered packet seq 41215 -> 41213 Jun 20 18:00:38 axiomair-888acb root[1176]: 2025-06-20 06:00:38.446354 PM [AirPlay] ### Misordered packet seq 41215 -> 41214 Jun 20 18:00:38 axiomair-888acb root[1176]: 2025-06-20 06:00:38.547614 PM [AirPlay] ### Misordered packet seq 41230 -> 41222 Jun 20 18:00:38 axiomair-888acb root[1176]: 2025-06-20 06:00:38.548002 PM [AirPlay] ### Misordered packet seq 41230 -> 41225 Jun 20 18:00:38 axiomair-888acb root[1176]: 2025-06-20 06:00:38.548175 PM [AirPlay] ### Misordered packet seq 41230 -> 41227 Jun 20 18:00:38 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:38 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:39 axiomair-888acb root[1176]: 2025-06-20 06:00:39.224155 PM [AirPlay] ### Misordered packet seq 41318 -> 41316 Jun 20 18:00:39 axiomair-888acb root[1176]: 2025-06-20 06:00:39.453427 PM [AirPlay] ### Misordered packet seq 41335 -> 41330 Jun 20 18:00:39 axiomair-888acb root[1176]: 2025-06-20 06:00:39.458922 PM [AirPlay] ### Misordered packet seq 41338 -> 41336 Jun 20 18:00:39 axiomair-888acb root[1176]: 2025-06-20 06:00:39.459388 PM [AirPlay] ### Misordered packet seq 41338 -> 41337 Jun 20 18:00:39 axiomair-888acb sudo[19326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-20 17:59 Jun 20 18:00:39 axiomair-888acb sudo[19326]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 18:00:39 axiomair-888acb lircd[829]: lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jun 20 18:00:39 axiomair-888acb lircd-0.9.4c[829]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' PRETTY_NAME="Raspbian GNU/Linux 9 (stretch)" NAME="Raspbian GNU/Linux" VERSION_ID="9" VERSION="9 (stretch)" VERSION_CODENAME=stretch 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_FE_VERSION="187be2f9c830c4fe312adf5ee10d6ca76c1221c8" VOLUMIO_BE_VERSION="f0b88cdc7b76371e2de89b66317a3eb412b85d57" VOLUMIO_ARCH="arm" VERSION="V2.13.4" VOLUMIO_VERSION="V2.13.4 - Toasted Cherry" VOLUMIO_VARIANT="AxiomAir" VOLUMIO_HARDWARE="AxiomAir" VOLUMIO_BUILD_DATE="2021-10-15"