-- Logs begin at Fri 2024-05-10 08:48:37 UTC, end at Mon 2024-07-22 13:11:31 UTC. -- Jul 22 13:11:07 myair ntpd[685]: receive: Unexpected origin timestamp 0xe9e85e32.d602e6ea does not match aorg 0000000000.00000000 from server@217.198.219.102 xmt 0xea48d8ea.ff792720 Jul 22 13:11:07 myair systemd[1]: Time has been changed Jul 22 13:11:07 myair ntpd[685]: receive: Unexpected origin timestamp 0xe9e85e32.d60bbde5 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xea48d8ea.ffcc92da Jul 22 13:11:07 myair systemd[1]: apt-daily-upgrade.timer: Adding 18min 29.926525s random time. Jul 22 13:11:07 myair systemd[1]: apt-daily.timer: Adding 1h 57min 24.019475s random time. Jul 22 13:11:07 myair systemd[1]: Starting Daily apt download activities... Jul 22 13:11:07 myair root[1106]: 2024-07-22 01:11:07.280094 PM [AirPlay] ### Lost packets 27435-27437 (+2, 2 total) Jul 22 13:11:07 myair volumio[416]: info: mDNS: A device disapperared from network Jul 22 13:11:07 myair volumio[416]: info: mDNS: Device myair disapperared from network Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair root[1106]: [2024/07/22 13:11:07:6836] NOTICE: time discontiguity: at old time 1715330994s, new time 1721653867s: +6322873s Jul 22 13:11:07 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:07 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:07 myair volumio[416]: info: mDNS: A device disapperared from network Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: info: mDNS: A device disapperared from network Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: info: mDNS: A device disapperared from network Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: Discovery: adding cfdbb967-d0a1-43c9-8123-137a9d0718a1 Jul 22 13:11:07 myair volumio[416]: info: mDNS: Found device myair Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: Discovery: this is already registered, cfdbb967-d0a1-43c9-8123-137a9d0718a1 Jul 22 13:11:07 myair volumio[416]: info: mDNS: Found device myair Jul 22 13:11:07 myair sudo[2225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:07 myair sudo[2225]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair sudo[2225]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:07 myair sudo[2229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:07 myair sudo[2229]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:07 myair volumio[416]: Discovery: this is already registered, cfdbb967-d0a1-43c9-8123-137a9d0718a1 Jul 22 13:11:07 myair volumio[416]: info: mDNS: Found device myair Jul 22 13:11:07 myair sudo[2229]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:07 myair sudo[2241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:07 myair volumio[416]: Discovery: this is already registered, cfdbb967-d0a1-43c9-8123-137a9d0718a1 Jul 22 13:11:07 myair volumio[416]: info: mDNS: Found device myair Jul 22 13:11:08 myair sudo[2241]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:08 myair sudo[2241]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:08 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:08 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:08 myair sudo[2261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:08 myair sudo[2261]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:08 myair sudo[2261]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:08 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:08 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:08 myair root[1106]: 2024-07-22 01:11:08.922983 PM [AirPlaySkew] Too many samples to skew: 334212237 Jul 22 13:11:09 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:09 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:09 myair systemd[1]: Started Daily apt download activities. Jul 22 13:11:09 myair systemd[1]: apt-daily.timer: Adding 6h 51min 39.796999s random time. Jul 22 13:11:09 myair systemd[1]: apt-daily.timer: Adding 6min 50.975535s random time. Jul 22 13:11:09 myair systemd[1]: Starting Daily apt upgrade and clean activities... Jul 22 13:11:10 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:10 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:11 myair systemd[1]: Started Daily apt upgrade and clean activities. Jul 22 13:11:11 myair systemd[1]: apt-daily-upgrade.timer: Adding 7min 9.695182s random time. Jul 22 13:11:11 myair systemd[1]: apt-daily-upgrade.timer: Adding 39min 57.716706s random time. Jul 22 13:11:11 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:11 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:12 myair root[1106]: [2024/07/22 13:11:12:3979] NOTICE: Sending : 2 Jul 22 13:11:12 myair root[1106]: [2024/07/22 13:11:12:3979] NOTICE: ping Jul 22 13:11:12 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:12 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:13 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:13 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:14 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:14 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:15 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:15 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:16 myair root[1106]: [2024/07/22 13:11:16:1732] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:16 myair root[1106]: "artwork_mime_type": "image\/jpeg", Jul 22 13:11:16 myair root[1106]: "artwork_file": "\/tmp\/airplay2.artwork.jpg" Jul 22 13:11:16 myair root[1106]: }}] Jul 22 13:11:16 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:16 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:16 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:16 myair root[1106]: 2024-07-22 01:11:16.201576 PM [Airtunesd] Received Play Status Update Message Jul 22 13:11:16 myair root[1106]: [2024/07/22 13:11:16:2017] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"1"}}] Jul 22 13:11:16 myair root[1106]: 2024-07-22 01:11:16.214008 PM [Airtunesd] Received Meta Data Update Message Jul 22 13:11:16 myair root[1106]: [2024/07/22 13:11:16:2142] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:16 myair root[1106]: "album": "Tired and Sick", Jul 22 13:11:16 myair root[1106]: "artist": "Otha", Jul 22 13:11:16 myair root[1106]: "genre": "", Jul 22 13:11:16 myair root[1106]: "title": "Tired and Sick" Jul 22 13:11:16 myair root[1106]: }}] Jul 22 13:11:16 myair sudo[2584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:16 myair sudo[2584]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair root[1106]: 2024-07-22 01:11:16.231797 PM [Airtunesd] Received and Unknown Update Message Jul 22 13:11:16 myair root[1106]: 2024-07-22 01:11:16.231923 PM [AirPlay] ### Command from Client Identifier 'updateMRSupportedCommands' failed: 400/0x190 Bad Request, -6714/0xFFFFE5C6 kNotHandledErr Jul 22 13:11:16 myair sudo[2586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair root[1106]: 2024-07-22 01:11:16.236853 PM [AirPlay] _requestProcessSetParameterText: dbVolume = -6.9 Jul 22 13:11:16 myair root[1106]: 2024-07-22 01:11:16.236991 PM [AirPlay] Setting volume to dB=-6.874999, linear=0.453158 Jul 22 13:11:16 myair root[1106]: 2024-07-22 01:11:16.237038 PM [AirPlay] _requestProcessSetParameterText:server volume set to -6.9 Jul 22 13:11:16 myair sudo[2586]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2584]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:16 myair sudo[2586]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair sudo[2598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair volumio[416]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jul 22 13:11:16 myair volumio[416]: info: Airplay started streaming Jul 22 13:11:16 myair volumio[416]: info: AIRPLAY: Un-Docking Jul 22 13:11:16 myair sudo[2598]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2598]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:16 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:16 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:16 myair root[1106]: [2024/07/22 13:11:16:3007] NOTICE: Sending : 42["volume", 77] Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:16 myair sudo[2613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:16 myair sudo[2613]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair sudo[2613]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair sudo[2616]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:16 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:16 myair sudo[2616]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:16 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:16 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:16 myair sudo[2625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair sudo[2625]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2625]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:16 myair sudo[2637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:16 myair sudo[2637]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2637]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair sudo[2644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:16 myair sudo[2644]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2644]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair sudo[2650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair sudo[2650]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:16 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:16 myair sudo[2650]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:16 myair volumio[416]: info: VolumeController::SetAlsaVolume77 Jul 22 13:11:16 myair volumio[416]: amixer -M set -c 0 "Digital" 77% Jul 22 13:11:16 myair volumio[416]: null Jul 22 13:11:16 myair volumio[416]: info: VolumeController::Volume 77 Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:16 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:16 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:16 myair sudo[2668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:16 myair sudo[2668]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2668]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair sudo[2671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:16 myair sudo[2671]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2671]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair sudo[2678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair sudo[2678]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2678]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:16 myair root[1106]: [2024/07/22 13:11:16:6543] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Progress","data":{"elapsed":"66.182063","duration":"172.171995"}}] Jul 22 13:11:16 myair volumio[416]: info: CALLMETHOD: music_service airplay2 Progress [object Object] Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Progress Jul 22 13:11:16 myair volumio[416]: 66182 Jul 22 13:11:16 myair volumio[416]: 66182 Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:16 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:16 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:16 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:16 myair sudo[2695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:16 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:16 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:16 myair sudo[2695]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair sudo[2695]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:16 myair sudo[2698]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:16 myair sudo[2703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:16 myair sudo[2698]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:16 myair sudo[2703]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:16 myair sudo[2703]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:17 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:17 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:18 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:18 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:19 myair systemd[1]: sys-subsystem-bluetooth-devices-hci0.device: Job sys-subsystem-bluetooth-devices-hci0.device/start timed out. Jul 22 13:11:19 myair systemd[1]: Timed out waiting for device sys-subsystem-bluetooth-devices-hci0.device. Jul 22 13:11:19 myair systemd[1]: sys-subsystem-bluetooth-devices-hci0.device: Job sys-subsystem-bluetooth-devices-hci0.device/start failed with result 'timeout'. Jul 22 13:11:19 myair systemd[1]: Startup finished in 9.884s (kernel) + 1min 30.963s (userspace) = 1min 40.847s. Jul 22 13:11:19 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:19 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:20 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:20 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:21 myair root[1106]: 2024-07-22 01:11:21.045166 PM [Airtunesd] Received Meta Data Update Message Jul 22 13:11:21 myair root[1106]: [2024/07/22 13:11:21:0453] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:21 myair root[1106]: "album": "Wanted", Jul 22 13:11:21 myair root[1106]: "artist": "Yazz", Jul 22 13:11:21 myair root[1106]: "genre": "", Jul 22 13:11:21 myair root[1106]: "title": "The Only Way Is Up" Jul 22 13:11:21 myair root[1106]: }}] Jul 22 13:11:21 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:21 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:21 myair root[1106]: 2024-07-22 01:11:21.052982 PM [Airtunesd] Received Play Status Update Message Jul 22 13:11:21 myair root[1106]: [2024/07/22 13:11:21:0531] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"1"}}] Jul 22 13:11:21 myair root[1106]: 2024-07-22 01:11:21.063729 PM [Airtunesd] Received Meta Data Update Message Jul 22 13:11:21 myair root[1106]: [2024/07/22 13:11:21:0640] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:21 myair root[1106]: "artwork_mime_type": "image\/none", Jul 22 13:11:21 myair root[1106]: "artwork_file": "\/tmp\/airplay2.artwork.jpg" Jul 22 13:11:21 myair root[1106]: }}] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair root[1106]: 2024-07-22 01:11:21.081506 PM [Airtunesd] Received Meta Data Update Message Jul 22 13:11:21 myair root[1106]: [2024/07/22 13:11:21:0827] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:21 myair root[1106]: "album": "Wanted", Jul 22 13:11:21 myair root[1106]: "artist": "Yazz", Jul 22 13:11:21 myair root[1106]: "genre": "", Jul 22 13:11:21 myair root[1106]: "title": "The Only Way Is Up" Jul 22 13:11:21 myair root[1106]: }}] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2740]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2740]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair sudo[2747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair root[1106]: 2024-07-22 01:11:21.113368 PM [Airtunesd] Received Meta Data Update Message Jul 22 13:11:21 myair sudo[2750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair sudo[2747]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2750]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair volumio[416]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jul 22 13:11:21 myair volumio[416]: info: Airplay started streaming Jul 22 13:11:21 myair volumio[416]: info: AIRPLAY: Un-Docking Jul 22 13:11:21 myair sudo[2747]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2750]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair root[1106]: [2024/07/22 13:11:21:1581] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:21 myair root[1106]: "artwork_mime_type": "image\/jpeg", Jul 22 13:11:21 myair root[1106]: "artwork_file": "\/tmp\/airplay2.artwork.jpg" Jul 22 13:11:21 myair root[1106]: }}] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:21 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2770]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair sudo[2770]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair sudo[2772]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:21 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:21 myair sudo[2779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair sudo[2772]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2779]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2779]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2793]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2793]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair sudo[2800]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair sudo[2800]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:21 myair sudo[2811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:21 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:21 myair sudo[2811]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2811]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2822]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair sudo[2822]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair sudo[2827]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2827]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair sudo[2832]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2832]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:21 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:21 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:21 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:21 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2851]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2851]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair sudo[2854]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:21 myair sudo[2859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:21 myair sudo[2854]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2859]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair root[1106]: 2024-07-22 01:11:21.563496 PM [Airtunesd] Received Meta Data Update Message Jul 22 13:11:21 myair root[1106]: [2024/07/22 13:11:21:5636] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:21 myair root[1106]: "album": "Wanted", Jul 22 13:11:21 myair root[1106]: "artist": "Yazz", Jul 22 13:11:21 myair root[1106]: "genre": "", Jul 22 13:11:21 myair root[1106]: "title": "The Only Way Is Up" Jul 22 13:11:21 myair root[1106]: }}] Jul 22 13:11:21 myair sudo[2859]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair root[1106]: 2024-07-22 01:11:21.569533 PM [Airtunesd] Received Play Status Update Message Jul 22 13:11:21 myair root[1106]: [2024/07/22 13:11:21:5696] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"1"}}] Jul 22 13:11:21 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:21 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:21 myair root[1106]: 2024-07-22 01:11:21.586709 PM [Airtunesd] Received Meta Data Update Message Jul 22 13:11:21 myair root[1106]: [2024/07/22 13:11:21:5868] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:21 myair root[1106]: "album": "Wanted", Jul 22 13:11:21 myair root[1106]: "artist": "Yazz", Jul 22 13:11:21 myair root[1106]: "genre": "", Jul 22 13:11:21 myair root[1106]: "title": "The Only Way Is Up" Jul 22 13:11:21 myair root[1106]: }}] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2878]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair root[1106]: 2024-07-22 01:11:21.628284 PM [Airtunesd] Received Meta Data Update Message Jul 22 13:11:21 myair sudo[2881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair sudo[2878]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair volumio[416]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jul 22 13:11:21 myair volumio[416]: info: Airplay started streaming Jul 22 13:11:21 myair volumio[416]: info: AIRPLAY: Un-Docking Jul 22 13:11:21 myair sudo[2881]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2881]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:21 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:21 myair sudo[2890]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2890]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:21 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2905]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair sudo[2905]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2910]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair sudo[2915]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:21 myair sudo[2910]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:21 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:21 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:21 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:21 myair sudo[2915]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:21 myair sudo[2936]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:21 myair sudo[2939]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2936]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:21 myair sudo[2939]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair sudo[2944]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:21 myair sudo[2944]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:21 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:22 myair root[1106]: [2024/07/22 13:11:22:5059] NOTICE: Sending : 2 Jul 22 13:11:22 myair root[1106]: [2024/07/22 13:11:22:5060] NOTICE: ping Jul 22 13:11:22 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:22 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:23 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:23 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:24 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:24 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:25 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:25 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:26 myair root[1106]: [2024/07/22 13:11:26:2262] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:26 myair root[1106]: "artwork_mime_type": "image\/jpeg", Jul 22 13:11:26 myair root[1106]: "artwork_file": "\/tmp\/airplay2.artwork.jpg" Jul 22 13:11:26 myair root[1106]: }}] Jul 22 13:11:26 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:26 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:26 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:26 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:26 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:26 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:26 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:26 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:26 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:26 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:26 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:26 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:26 myair sudo[2973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:26 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:26 myair sudo[2973]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:26 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:26 myair sudo[2976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:26 myair sudo[2973]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:26 myair sudo[2981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:26 myair sudo[2976]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:26 myair sudo[2981]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:26 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:26 myair sudo[2976]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:26 myair sudo[2981]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:26 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:26 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:27 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:27 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:27 myair volumio[1091]: [Vollibrespot] : Connecting to AP "ap-gew4.spotify.com:4070" Jul 22 13:11:28 myair volumio[1091]: [Vollibrespot] : Authenticated as "113188796" ! Jul 22 13:11:28 myair volumio[1091]: [Vollibrespot] : Using alsa sink Jul 22 13:11:28 myair volumio[1091]: [Vollibrespot] : Country: "DK" Jul 22 13:11:28 myair volumio[1091]: [Vollibrespot] : Metadata pipe established Jul 22 13:11:28 myair volumio[416]: [SpotifyConnect] Volume: Sp:49.999237048905165 Volumio: 50 Jul 22 13:11:28 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:28 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:28 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:28 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:28 myair sudo[3010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:28 myair sudo[3010]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:28 myair sudo[3010]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:28 myair sudo[3014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:28 myair sudo[3014]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:28 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:28 myair sudo[3014]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:28 myair sudo[3023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:28 myair sudo[3023]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:28 myair sudo[3023]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:28 myair volumio[416]: info: VolumeController::SetAlsaVolume32767 Jul 22 13:11:28 myair volumio[416]: amixer -M set -c 0 "Digital" 49.999237048905165% Jul 22 13:11:28 myair volumio[416]: null Jul 22 13:11:28 myair volumio[416]: info: VolumeController::Volume 49.999237048905165 Jul 22 13:11:28 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:28 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:28 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:28 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:28 myair sudo[3038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:28 myair sudo[3038]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:28 myair sudo[3041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:28 myair sudo[3038]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:28 myair sudo[3041]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:28 myair sudo[3041]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:28 myair sudo[3047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:28 myair sudo[3047]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:28 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:28 myair sudo[3047]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:28 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:28 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:28 myair volumio[1091]: [Vollibrespot] : SessionActive! Jul 22 13:11:28 myair volumio[416]: [SpotifyConnect] Connect Session is active! Jul 22 13:11:28 myair volumio[1091]: [Vollibrespot] : Loading track "The Only Way Is Up" with Spotify URI "spotify:track:0QmL9PTzMnBW1SeFmJmDF9" Jul 22 13:11:28 myair root[1106]: 2024-07-22 01:11:28.915816 PM [Airtunesd] Received Meta Data Update Message Jul 22 13:11:28 myair root[1106]: [2024/07/22 13:11:28:9160] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:28 myair root[1106]: "album": "Wanted", Jul 22 13:11:28 myair root[1106]: "artist": "Afspiller på myair", Jul 22 13:11:28 myair root[1106]: "genre": "", Jul 22 13:11:28 myair root[1106]: "title": "The Only Way Is Up • Yazz" Jul 22 13:11:28 myair root[1106]: }}] Jul 22 13:11:28 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:28 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:28 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:28 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:28 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:28 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:28 myair root[1106]: 2024-07-22 01:11:28.924314 PM [Airtunesd] Received Play Status Update Message Jul 22 13:11:28 myair root[1106]: [2024/07/22 13:11:28:9244] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"1"}}] Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:28 myair sudo[3065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:28 myair sudo[3065]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:28 myair sudo[3065]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:28 myair sudo[3068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:28 myair sudo[3068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:28 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:28 myair sudo[3068]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:28 myair sudo[3076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:28 myair sudo[3076]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair volumio[416]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jul 22 13:11:29 myair volumio[416]: info: Airplay started streaming Jul 22 13:11:29 myair sudo[3076]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair volumio[416]: info: AIRPLAY: Un-Docking Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:29 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:29 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:29 myair sudo[3094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:29 myair sudo[3094]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair sudo[3094]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair sudo[3097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:29 myair sudo[3097]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair sudo[3103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:29 myair sudo[3097]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:29 myair sudo[3103]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair sudo[3103]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair volumio[416]: [SpotifyConnect] Pushing metadata Vollibrespot: false Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::volumioGetState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:29 myair volumio[416]: [SpotifyConnect] Currently active: airplay Jul 22 13:11:29 myair volumio[416]: [SpotifyConnect] Pushing new state :: false Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:29 myair volumio[416]: info: CorePlayQueue::getTrack 0 Jul 22 13:11:29 myair volumio[416]: info: STATE SERVICE {"status":"stop","service":"volspotconnect2","title":"The Only Way Is Up","artist":"Yazz","album":"Wanted","albumart":"https://i.scdn.co/image/ab67616d0000b273803e9cef4fc11a948f485a6b","uri":"spotify:track:0QmL9PTzMnBW1SeFmJmDF9","trackType":"spotify","seek":0,"duration":269,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 22 13:11:29 myair volumio[416]: info: CURRENT POSITION 0 Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::syncState stateService stop Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::syncState currentStatus play Jul 22 13:11:29 myair volumio[416]: info: CURRENT POSITION 0 Jul 22 13:11:29 myair volumio[416]: info: END OF QUEUE Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::pushEmptyState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:29 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - stop, service - mpd Jul 22 13:11:29 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:29 myair sudo[3123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair sudo[3123]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair sudo[3125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::stPlaybackTimer Jul 22 13:11:29 myair sudo[3123]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair volumio[416]: [SpotifyConnect] Token: Jul 22 13:11:29 myair sudo[3125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair sudo[3131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair sudo[3125]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair sudo[3131]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair sudo[3131]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair volumio[416]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false} Jul 22 13:11:29 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:29 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:29 myair root[1106]: 2024-07-22 01:11:29.726839 PM [Airtunesd] Received Meta Data Update Message Jul 22 13:11:29 myair root[1106]: [2024/07/22 13:11:29:7270] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"MetaData","data":{ Jul 22 13:11:29 myair root[1106]: "album": "Wanted", Jul 22 13:11:29 myair root[1106]: "artist": "Afspiller på myair", Jul 22 13:11:29 myair root[1106]: "genre": "", Jul 22 13:11:29 myair root[1106]: "title": "The Only Way Is Up • Yazz" Jul 22 13:11:29 myair root[1106]: }}] Jul 22 13:11:29 myair volumio[416]: info: CALLMETHOD: music_service airplay2 MetaData [object Object] Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , MetaData Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:29 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:29 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:29 myair sudo[3150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair sudo[3150]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:29 myair root[1106]: 2024-07-22 01:11:29.784385 PM [Airtunesd] Received Play Status Update Message Jul 22 13:11:29 myair root[1106]: [2024/07/22 13:11:29:7845] NOTICE: Sending : 42["callMethod", {"endpoint":"music_service/airplay2","method":"Playing","data":{"status":"1"}}] Jul 22 13:11:29 myair sudo[3152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair sudo[3150]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair volumio[416]: info: CALLMETHOD: music_service airplay2 Playing [object Object] Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: airplay2 , Playing Jul 22 13:11:29 myair volumio[416]: info: Airplay started streaming Jul 22 13:11:29 myair volumio[416]: info: AIRPLAY: Un-Docking Jul 22 13:11:29 myair sudo[3152]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair sudo[3157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair sudo[3152]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair sudo[3157]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::servicePushState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::syncState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::pushState Jul 22 13:11:29 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::volumioPushState Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:29 myair volumio[416]: info: VOLUMIO PUSHED THIS STATE: status - play, service - airplay Jul 22 13:11:29 myair volumio[416]: info: interfaceApi::pushState Jul 22 13:11:29 myair sudo[3157]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:29 myair sudo[3180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getDevices Jul 22 13:11:29 myair sudo[3180]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair sudo[3180]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair sudo[3184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair volumio[416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 13:11:29 myair sudo[3184]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:29 myair volumio[416]: info: Pushing Favourites {"service":"airplay","uri":"","favourite":false} Jul 22 13:11:29 myair sudo[3184]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:29 myair sudo[3189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 22 13:11:29 myair sudo[3189]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 13:11:29 myair sudo[3189]: pam_unix(sudo:session): session closed for user root Jul 22 13:11:30 myair volumio[1091]: [Vollibrespot] : Track "The Only Way Is Up" loaded Jul 22 13:11:30 myair volumio[416]: [SpotifyConnect] Device is active! Jul 22 13:11:30 myair volumio[416]: info: CoreCommandRouter::volumioGetState Jul 22 13:11:30 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:30 myair volumio[416]: [SpotifyConnect] Currently active: airplay Jul 22 13:11:30 myair volumio[416]: [SpotifyConnect] Stopping currently active service Jul 22 13:11:30 myair volumio[1091]: [Vollibrespot] : Alsa error PCM open ALSA function 'snd_pcm_open' failed with error 'EBUSY: Device or resource busy' Jul 22 13:11:30 myair volumio[1091]: [Vollibrespot] : Could not start audio: Alsa error: PCM open failed Jul 22 13:11:30 myair volumio[1091]: [Vollibrespot] : Alsa error PCM open ALSA function 'snd_pcm_open' failed with error 'EBUSY: Device or resource busy' Jul 22 13:11:30 myair volumio[1091]: [Vollibrespot] : Could not start audio: Alsa error: PCM open failed Jul 22 13:11:30 myair volumio[416]: info: CoreCommandRouter::volumioStop Jul 22 13:11:30 myair volumio[416]: info: CoreStateMachine::getState Jul 22 13:11:30 myair volumio[416]: info: VOLUMIOSTOP: service stopped - airplay Jul 22 13:11:30 myair volumio[416]: info: CoreStateMachine::stop Jul 22 13:11:30 myair volumio[416]: info: CoreStateMachine::serviceStop Jul 22 13:11:30 myair volumio[416]: info: CoreCommandRouter::serviceStop Jul 22 13:11:30 myair volumio[416]: error: WARNING: No stop method for service airplay Jul 22 13:11:30 myair volumio[416]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 13:11:30 myair volumio[416]: TypeError: Cannot read property 'then' of undefined Jul 22 13:11:30 myair volumio[416]: at SpotConnEvents. (/volumio/app/plugins/music_service/volspotconnect2/index.js:148:23) Jul 22 13:11:30 myair volumio[416]: at emitOne (events.js:116:13) Jul 22 13:11:30 myair volumio[416]: at SpotConnEvents.emit (events.js:211:7) Jul 22 13:11:30 myair volumio[416]: at SpotConnEvents.parseData (/volumio/app/plugins/music_service/volspotconnect2/SpotConnController.js:48:16) Jul 22 13:11:30 myair volumio[416]: at Socket.SpotConnEvents._udpsource.on.msg (/volumio/app/plugins/music_service/volspotconnect2/SpotConnController.js:15:12) Jul 22 13:11:30 myair volumio[416]: at emitTwo (events.js:126:13) Jul 22 13:11:30 myair volumio[416]: at Socket.emit (events.js:214:7) Jul 22 13:11:30 myair volumio[416]: at UDP.onMessage [as onmessage] (dgram.js:659:8) Jul 22 13:11:30 myair volumio[416]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 13:11:30 myair lircd[719]: lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:30 myair lircd-0.9.4c[719]: Error: unable to open '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jul 22 13:11:31 myair sudo[3218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 13:10 Jul 22 13:11:31 myair sudo[3218]: pam_unix(sudo:session): session opened for user root by (uid=0) 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="47ab3b567cf0a562ecf4682a54cba4be0c4c2f3f" VOLUMIO_ARCH="arm" VERSION="V2.13.2" VOLUMIO_VERSION="V2.13.2 - Toasted Cherry" VOLUMIO_VARIANT="AxiomAir" VOLUMIO_HARDWARE="AxiomAir" VOLUMIO_BUILD_DATE="2020-12-29"