airupnp-log-debug

❯ ~/bin/airupnp-macos-arm64-static -d all=sdebug                      10:56:11
[10:58:00.937995] main:1360 Starting airupnp version: v1.0.14 (Jan 25 2023 @ 12:47:31)
[10:58:00.942034] main:1367 no config file, using defaults
[10:58:00.942357] Start:1083 Binding to iface en0@192.168.2.13:0
[10:58:01.100370] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:58:01.139907] AddMRDevice:913 UDN:  uuid:RINCON_949F3E91E91201400
FriendlyName:   192.168.2.25 - Sonos Sub
[10:58:01.139920] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:01.139924] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:01.139926] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:01.139927] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:01.139928] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:01.139930] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:01.139931] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:01.139933] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:01.139935] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:01.139937] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:01.139953] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:01.139957] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:01.139959] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:01.139961] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:01.139962] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:01.139963] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:01.139966] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:01.139968] XMLFindAndParseService:328 Service I, serviceId: urn:upnp-org:serviceId:RenderingControl
[10:58:01.139973] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:01.139976] AddMRDevice:945       service [urn:schemas-upnp-org:service:RenderingControl] urn:schemas-upnp-org:service:RenderingControl:1 urn:upnp-org:serviceId:RenderingControl, http://192.168.2.25:1400/MediaRenderer/RenderingControl/Event, http://192.168.2.25:1400/MediaRenderer/RenderingControl/Control
[10:58:01.139995] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:01.139999] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:01.140000] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:01.140001] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:01.140003] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:01.140004] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:01.140005] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:01.140008] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:01.140009] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:01.140012] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:01.140015] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:01.140016] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:01.140017] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:01.140019] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:01.140020] XMLFindAndParseService:328 Service , serviceId: urn:upnp-org:serviceId:ZoneGroupTopology
[10:58:01.140025] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:01.140028] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:01.140029] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:01.140031] AddMRDevice:945       service [urn:schemas-upnp-org:service:ZoneGroupTopology] urn:schemas-upnp-org:service:ZoneGroupTopology:1 urn:upnp-org:serviceId:ZoneGroupTopology, http://192.168.2.25:1400/ZoneGroupTopology/Event, http://192.168.2.25:1400/ZoneGroupTopology/Control
[10:58:01.140035] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:01.140038] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:01.140039] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:01.140040] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:01.140042] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:01.140043] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:01.140044] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:01.140047] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:01.140049] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:01.173791] GetMaster:114 [0x128008000]: Master not discovered yet, assigning to self
[10:58:01.173829] AddMRDevice:1007 [0x128008000] skipping Sonos slave 192.168.2.25 - Sonos Sub
[10:58:01.173874] MRThread:241 [0x128008000]: UPnP thread timer 0 5000
[10:58:01.195570] MasterHandler:557 event: 11 [UPNP_EVENT_SUBSCRIBE_COMPLETE] [0x600003a9c120] (recurse 0)
[10:58:01.195584] MasterHandler:642 [0x128008000]: subscribe fail, re-trying 1
[10:58:01.225628] MasterHandler:557 event: 11 [UPNP_EVENT_SUBSCRIBE_COMPLETE] [0x600003a94000] (recurse 0)
[10:58:01.225646] MasterHandler:642 [0x128008000]: subscribe fail, re-trying 2
[10:58:01.252389] MasterHandler:557 event: 11 [UPNP_EVENT_SUBSCRIBE_COMPLETE] [0x600003a9c120] (recurse 0)
[10:58:01.252407] MasterHandler:642 [0x128008000]: subscribe fail, re-trying 3
[10:58:01.266663] MasterHandler:557 event: 11 [UPNP_EVENT_SUBSCRIBE_COMPLETE] [0x600003a9c120] (recurse 0)
[10:58:01.266676] MasterHandler:646 [0x128008000]: subscribe fail, volume feedback will not work
[10:58:01.298318] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:58:01.316853] AddMRDevice:913 UDN:  uuid:RINCON_38420B2217E001400
FriendlyName:   192.168.2.24 - Sonos Amp
[10:58:01.316860] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:01.316865] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:01.316867] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:MusicServices:1
[10:58:01.316868] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:01.316869] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:01.316871] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:01.316872] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:01.316873] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:HTControl:1
[10:58:01.316874] XMLFindAndParseService:317 serviceType urn:schemas-tencent-com:service:QPlay:1
[10:58:01.316876] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AudioIn:1
[10:58:01.316885] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:01.316893] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ContentDirectory:1
[10:58:01.316895] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:01.316896] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:01.316900] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:01.316901] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:01.316903] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AVTransport:1
[10:58:01.316904] XMLFindAndParseService:328 Service �I, serviceId: urn:upnp-org:serviceId:AVTransport
[10:58:01.316910] XMLGetNthServiceList:259 GetNthServiceList called : n = 3
[10:58:01.316913] AddMRDevice:945       service [urn:schemas-upnp-org:service:AVTransport] urn:schemas-upnp-org:service:AVTransport:1 urn:upnp-org:serviceId:AVTransport, http://192.168.2.24:1400/MediaRenderer/AVTransport/Event, http://192.168.2.24:1400/MediaRenderer/AVTransport/Control
[10:58:01.316917] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:01.316920] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:01.316922] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:MusicServices:1
[10:58:01.316923] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:01.316925] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:01.316926] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:01.316928] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:01.316929] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:HTControl:1
[10:58:01.316931] XMLFindAndParseService:317 serviceType urn:schemas-tencent-com:service:QPlay:1
[10:58:01.316932] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AudioIn:1
[10:58:01.316933] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:01.316936] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ContentDirectory:1
[10:58:01.316938] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:01.316939] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:01.316942] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:01.316944] XMLFindAndParseService:328 Service I, serviceId: urn:upnp-org:serviceId:RenderingControl
[10:58:01.316947] XMLGetNthServiceList:259 GetNthServiceList called : n = 3
[10:58:01.316950] AddMRDevice:945       service [urn:schemas-upnp-org:service:RenderingControl] urn:schemas-upnp-org:service:RenderingControl:1 urn:upnp-org:serviceId:RenderingControl, http://192.168.2.24:1400/MediaRenderer/RenderingControl/Event, http://192.168.2.24:1400/MediaRenderer/RenderingControl/Control
[10:58:01.316953] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:01.316957] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:01.316958] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:MusicServices:1
[10:58:01.316960] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:01.316961] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:01.316962] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:01.316964] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:01.316965] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:HTControl:1
[10:58:01.316966] XMLFindAndParseService:317 serviceType urn:schemas-tencent-com:service:QPlay:1
[10:58:01.316968] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AudioIn:1
[10:58:01.316969] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:01.316972] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ContentDirectory:1
[10:58:01.316973] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:01.316975] XMLFindAndParseService:328 Service , serviceId: urn:upnp-org:serviceId:ConnectionManager
[10:58:01.316979] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:01.316982] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:01.316983] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:01.316985] XMLFindAndParseService:328 Service , serviceId: urn:upnp-org:serviceId:ConnectionManager
[10:58:01.316988] XMLGetNthServiceList:259 GetNthServiceList called : n = 3
[10:58:01.316990] AddMRDevice:945       service [urn:schemas-upnp-org:service:ConnectionManager] urn:schemas-upnp-org:service:ConnectionManager:1 urn:upnp-org:serviceId:ConnectionManager, http://192.168.2.24:1400/MediaRenderer/ConnectionManager/Event, http://192.168.2.24:1400/MediaRenderer/ConnectionManager/Control
[10:58:01.316994] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:01.316998] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:01.316999] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:MusicServices:1
[10:58:01.317001] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:01.317002] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:01.317003] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:01.317005] XMLFindAndParseService:328 Service , serviceId: urn:upnp-org:serviceId:ZoneGroupTopology
[10:58:01.317008] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:01.317012] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ContentDirectory:1
[10:58:01.317013] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:01.317014] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:01.317017] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:01.317019] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:01.317020] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AVTransport:1
[10:58:01.317021] XMLFindAndParseService:317 serviceType urn:schemas-sonos-com:service:Queue:1
[10:58:01.317023] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupRenderingControl:1
[10:58:01.317024] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:VirtualLineIn:1
[10:58:01.317025] XMLGetNthServiceList:259 GetNthServiceList called : n = 3
[10:58:01.317028] AddMRDevice:945       service [urn:schemas-upnp-org:service:ZoneGroupTopology] urn:schemas-upnp-org:service:ZoneGroupTopology:1 urn:upnp-org:serviceId:ZoneGroupTopology, http://192.168.2.24:1400/ZoneGroupTopology/Event, http://192.168.2.24:1400/ZoneGroupTopology/Control
[10:58:01.317031] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:01.317040] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:01.317042] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:MusicServices:1
[10:58:01.317043] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:01.317044] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:01.317046] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:01.317047] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:01.317048] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:HTControl:1
[10:58:01.317049] XMLFindAndParseService:317 serviceType urn:schemas-tencent-com:service:QPlay:1
[10:58:01.317051] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AudioIn:1
[10:58:01.317052] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:01.317058] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ContentDirectory:1
[10:58:01.317060] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:01.317061] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:01.317064] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:01.317066] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:01.317067] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AVTransport:1
[10:58:01.317068] XMLFindAndParseService:317 serviceType urn:schemas-sonos-com:service:Queue:1
[10:58:01.317070] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupRenderingControl:1
[10:58:01.317071] XMLFindAndParseService:328 Service , serviceId: urn:upnp-org:serviceId:GroupRenderingControl
[10:58:01.317075] XMLGetNthServiceList:259 GetNthServiceList called : n = 3
[10:58:01.317078] AddMRDevice:945       service [urn:schemas-upnp-org:service:GroupRenderingControl] urn:schemas-upnp-org:service:GroupRenderingControl:1 urn:upnp-org:serviceId:GroupRenderingControl, http://192.168.2.24:1400/MediaRenderer/GroupRenderingControl/Event, http://192.168.2.24:1400/MediaRenderer/GroupRenderingControl/Control
[10:58:01.350890] AddMRDevice:1009 [0x12800a3c0]: adding renderer (Living Room) with mac BBBBE017220B
[10:58:01.350929] MRThread:241 [0x12800a3c0]: UPnP thread timer 0 5000
[10:58:01.350968] bind_socket:636 socket binding 10 on port 62019
[10:58:01.371168] MasterHandler:557 event: 11 [UPNP_EVENT_SUBSCRIBE_COMPLETE] [0x600003a94000] (recurse 0)
[10:58:01.371184] MasterHandler:640 [0x12800a3c0]: subscribe success
[10:58:01.413547] MasterHandler:557 event: 9 [UPNP_EVENT_RECEIVED] [0x0] (recurse 0)
[10:58:01.413625] ProcessEvent:445 [0x12800a3c0]: UPnP Volume local change 31:31 (master)
[10:58:02.166507] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:58:02.186923] AddMRDevice:913 UDN:  uuid:RINCON_000E58D4A64201400
FriendlyName:   192.168.2.26 - Sonos Connect:Amp
[10:58:02.186936] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:02.186942] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:02.186943] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:MusicServices:1
[10:58:02.186945] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AudioIn:1
[10:58:02.186947] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:02.186948] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:02.186950] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:02.186952] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:02.186954] XMLFindAndParseService:317 serviceType urn:schemas-tencent-com:service:QPlay:1
[10:58:02.186955] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:02.186958] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ContentDirectory:1
[10:58:02.186960] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:02.186961] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:02.186964] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:02.186966] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:02.186967] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AVTransport:1
[10:58:02.186969] XMLFindAndParseService:328 Service @
I, serviceId: urn:upnp-org:serviceId:AVTransport
[10:58:02.186974] XMLGetNthServiceList:259 GetNthServiceList called : n = 3
[10:58:02.186978] AddMRDevice:945       service [urn:schemas-upnp-org:service:AVTransport] urn:schemas-upnp-org:service:AVTransport:1 urn:upnp-org:serviceId:AVTransport, http://192.168.2.26:1400/MediaRenderer/AVTransport/Event, http://192.168.2.26:1400/MediaRenderer/AVTransport/Control
[10:58:02.186982] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:02.186985] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:02.186987] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:MusicServices:1
[10:58:02.186988] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AudioIn:1
[10:58:02.186990] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:02.186991] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:02.186992] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:02.186994] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:02.186995] XMLFindAndParseService:317 serviceType urn:schemas-tencent-com:service:QPlay:1
[10:58:02.186997] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:02.187000] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ContentDirectory:1
[10:58:02.187002] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:02.187003] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:02.187007] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:02.187008] XMLFindAndParseService:328 Service p
I, serviceId: urn:upnp-org:serviceId:RenderingControl
[10:58:02.187011] XMLGetNthServiceList:259 GetNthServiceList called : n = 3
[10:58:02.187014] AddMRDevice:945       service [urn:schemas-upnp-org:service:RenderingControl] urn:schemas-upnp-org:service:RenderingControl:1 urn:upnp-org:serviceId:RenderingControl, http://192.168.2.26:1400/MediaRenderer/RenderingControl/Event, http://192.168.2.26:1400/MediaRenderer/RenderingControl/Control
[10:58:02.187018] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:02.187022] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:02.187027] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:MusicServices:1
[10:58:02.187028] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AudioIn:1
[10:58:02.187029] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:02.187031] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:02.187032] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:02.187034] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:02.187035] XMLFindAndParseService:317 serviceType urn:schemas-tencent-com:service:QPlay:1
[10:58:02.187036] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:02.187039] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ContentDirectory:1
[10:58:02.187041] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:02.187047] XMLFindAndParseService:328 Service , serviceId: urn:upnp-org:serviceId:ConnectionManager
[10:58:02.187050] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:02.187053] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:02.187055] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:02.187056] XMLFindAndParseService:328 Service , serviceId: urn:upnp-org:serviceId:ConnectionManager
[10:58:02.187060] XMLGetNthServiceList:259 GetNthServiceList called : n = 3
[10:58:02.187063] AddMRDevice:945       service [urn:schemas-upnp-org:service:ConnectionManager] urn:schemas-upnp-org:service:ConnectionManager:1 urn:upnp-org:serviceId:ConnectionManager, http://192.168.2.26:1400/MediaRenderer/ConnectionManager/Event, http://192.168.2.26:1400/MediaRenderer/ConnectionManager/Control
[10:58:02.187066] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:02.187117] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:02.187128] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:MusicServices:1
[10:58:02.187130] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AudioIn:1
[10:58:02.187131] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:02.187133] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:02.187134] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:02.187137] XMLFindAndParseService:328 Service @@, serviceId: urn:upnp-org:serviceId:ZoneGroupTopology
[10:58:02.187143] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:02.187146] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ContentDirectory:1
[10:58:02.187148] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:02.187149] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:02.187152] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:02.187155] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:02.187157] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AVTransport:1
[10:58:02.187160] XMLFindAndParseService:317 serviceType urn:schemas-sonos-com:service:Queue:1
[10:58:02.187161] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupRenderingControl:1
[10:58:02.187163] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:VirtualLineIn:1
[10:58:02.187165] XMLGetNthServiceList:259 GetNthServiceList called : n = 3
[10:58:02.187167] AddMRDevice:945       service [urn:schemas-upnp-org:service:ZoneGroupTopology] urn:schemas-upnp-org:service:ZoneGroupTopology:1 urn:upnp-org:serviceId:ZoneGroupTopology, http://192.168.2.26:1400/ZoneGroupTopology/Event, http://192.168.2.26:1400/ZoneGroupTopology/Control
[10:58:02.187171] XMLGetNthServiceList:259 GetNthServiceList called : n = 0
[10:58:02.187176] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AlarmClock:1
[10:58:02.187178] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:MusicServices:1
[10:58:02.187179] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AudioIn:1
[10:58:02.187181] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:DeviceProperties:1
[10:58:02.187182] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:SystemProperties:1
[10:58:02.187184] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ZoneGroupTopology:1
[10:58:02.187186] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupManagement:1
[10:58:02.187188] XMLFindAndParseService:317 serviceType urn:schemas-tencent-com:service:QPlay:1
[10:58:02.187190] XMLGetNthServiceList:259 GetNthServiceList called : n = 1
[10:58:02.187195] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ContentDirectory:1
[10:58:02.187196] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:02.187198] XMLGetNthServiceList:259 GetNthServiceList called : n = 2
[10:58:02.187202] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:RenderingControl:1
[10:58:02.187204] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:ConnectionManager:1
[10:58:02.187205] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:AVTransport:1
[10:58:02.187207] XMLFindAndParseService:317 serviceType urn:schemas-sonos-com:service:Queue:1
[10:58:02.187208] XMLFindAndParseService:317 serviceType urn:schemas-upnp-org:service:GroupRenderingControl:1
[10:58:02.187210] XMLFindAndParseService:328 Service @@, serviceId: urn:upnp-org:serviceId:GroupRenderingControl
[10:58:02.187216] XMLGetNthServiceList:259 GetNthServiceList called : n = 3
[10:58:02.187221] AddMRDevice:945       service [urn:schemas-upnp-org:service:GroupRenderingControl] urn:schemas-upnp-org:service:GroupRenderingControl:1 urn:upnp-org:serviceId:GroupRenderingControl, http://192.168.2.26:1400/MediaRenderer/GroupRenderingControl/Event, http://192.168.2.26:1400/MediaRenderer/GroupRenderingControl/Control
[10:58:02.200694] AddMRDevice:1009 [0x12800c780]: adding renderer (Office) with mac BBBB42A6D458
[10:58:02.200750] MRThread:241 [0x12800c780]: UPnP thread timer 0 5000
[10:58:02.201094] bind_socket:636 socket binding 11 on port 62023
[10:58:02.233868] MasterHandler:557 event: 11 [UPNP_EVENT_SUBSCRIBE_COMPLETE] [0x600003a99380] (recurse 0)
[10:58:02.233883] MasterHandler:640 [0x12800c780]: subscribe success
[10:58:02.282269] MasterHandler:557 event: 9 [UPNP_EVENT_RECEIVED] [0x0] (recurse 0)
[10:58:02.282335] ProcessEvent:445 [0x12800c780]: UPnP Volume local change 53:53 (master)
[10:58:04.009851] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:58:06.178934] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:06.355982] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:58:07.205798] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:58:11.183992] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:11.361046] MRThread:241 [0x12800a3c0]: UPnP thread timer 5006 5000
[10:58:12.210857] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:58:16.189050] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:16.365970] MRThread:241 [0x12800a3c0]: UPnP thread timer 5004 5000
[10:58:17.215920] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:58:20.005167] MasterHandler:557 event: 7 [UPNP_DISCOVERY_SEARCH_TIMEOUT] [0x0] (recurse 0)
[10:58:20.005185] UpdateThread:692 Presence checking
[10:58:20.069843] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 1)
[10:58:20.090567] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 1)
[10:58:20.093986] UpdateThread:744 [0x12800a3c0] UPnP keep alive: Living Room+
[10:58:20.150596] UpdateThread:744 [0x12800c780] UPnP keep alive: Office+
[10:58:20.309406] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:58:20.322342] UpdateThread:744 [0x12800c780] UPnP keep alive: Office+
[10:58:20.367185] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:58:20.390778] UpdateThread:744 [0x12800a3c0] UPnP keep alive: Living Room+
[10:58:20.498801] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:58:20.522612] GetMaster:102 Found Master RINCON_949F3E91E91201400 uuid:RINCON_000E58D4A64201400
[10:58:20.522626] UpdateThread:744 [0x128008000] UPnP keep alive: 192.168.2.25 - Sonos Sub+
[10:58:20.557584] UpdateThread:775 [0x128008000]: Sonos 192.168.2.25 - Sonos Sub+ is now slave
[10:58:21.194109] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:21.371028] MRThread:241 [0x12800a3c0]: UPnP thread timer 5006 5000
[10:58:22.220978] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:58:26.199165] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:26.375418] MRThread:241 [0x12800a3c0]: UPnP thread timer 5004 5000
[10:58:27.226037] MRThread:241 [0x12800c780]: UPnP thread timer 5006 5000
[10:58:31.204223] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:31.380478] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:58:32.229078] MRThread:241 [0x12800c780]: UPnP thread timer 5003 5000
[10:58:36.209279] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:36.385535] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:58:37.234145] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:58:40.003586] MasterHandler:557 event: 7 [UPNP_DISCOVERY_SEARCH_TIMEOUT] [0x0] (recurse 0)
[10:58:40.003622] UpdateThread:692 Presence checking
[10:58:40.255919] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:58:40.273789] UpdateThread:744 [0x12800a3c0] UPnP keep alive: Living Room+
[10:58:40.317761] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:58:40.339726] GetMaster:102 Found Master RINCON_949F3E91E91201400 uuid:RINCON_000E58D4A64201400
[10:58:40.339739] UpdateThread:744 [0x128008000] UPnP keep alive: 192.168.2.25 - Sonos Sub+
[10:58:40.451353] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:58:40.464804] UpdateThread:744 [0x12800c780] UPnP keep alive: Office+
[10:58:41.214340] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:41.390590] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:58:42.234263] MRThread:241 [0x12800c780]: UPnP thread timer 5000 5000
[10:58:46.219399] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:46.395645] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:58:47.236874] MRThread:241 [0x12800c780]: UPnP thread timer 5002 5000
[10:58:49.535306] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:58:49.572627] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:58:49.760800] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:58:50.015081] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:58:50.084675] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:58:51.224458] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:51.400700] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:58:52.241930] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:58:56.229519] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:58:56.405756] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:58:57.246330] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:00.005154] MasterHandler:557 event: 7 [UPNP_DISCOVERY_SEARCH_TIMEOUT] [0x0] (recurse 0)
[10:59:00.005175] UpdateThread:692 Presence checking
[10:59:00.269182] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:59:00.292008] GetMaster:102 Found Master RINCON_949F3E91E91201400 uuid:RINCON_000E58D4A64201400
[10:59:00.292022] UpdateThread:744 [0x128008000] UPnP keep alive: 192.168.2.25 - Sonos Sub+
[10:59:00.539670] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:59:00.698854] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:59:00.711672] UpdateThread:744 [0x12800a3c0] UPnP keep alive: Living Room+
[10:59:00.768787] UpdateThread:744 [0x12800c780] UPnP keep alive: Office+
[10:59:01.234578] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:01.410814] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:59:02.251391] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:03.967409] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:59:06.239638] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:06.415870] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:59:07.256454] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:11.244698] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:11.420926] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:59:12.261511] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:16.249757] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:16.425982] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:59:17.266573] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:20.003282] MasterHandler:557 event: 7 [UPNP_DISCOVERY_SEARCH_TIMEOUT] [0x0] (recurse 0)
[10:59:20.003316] UpdateThread:692 Presence checking
[10:59:20.131952] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 1)
[10:59:20.146177] UpdateThread:744 [0x12800c780] UPnP keep alive: Office+
[10:59:20.346226] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:59:20.380282] GetMaster:102 Found Master RINCON_949F3E91E91201400 uuid:RINCON_000E58D4A64201400
[10:59:20.380296] UpdateThread:744 [0x128008000] UPnP keep alive: 192.168.2.25 - Sonos Sub+
[10:59:20.617352] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:59:20.649566] UpdateThread:744 [0x12800a3c0] UPnP keep alive: Living Room+
[10:59:21.254816] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:21.431039] MRThread:241 [0x12800a3c0]: UPnP thread timer 5006 5000
[10:59:22.271639] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:26.257364] MRThread:241 [0x128008000]: UPnP thread timer 5003 5000
[10:59:26.436096] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:59:27.276696] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:31.262425] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:31.438294] MRThread:241 [0x12800a3c0]: UPnP thread timer 5002 5000
[10:59:32.281752] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:36.267484] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:36.443357] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:59:37.284309] MRThread:241 [0x12800c780]: UPnP thread timer 5003 5000
[10:59:40.005154] MasterHandler:557 event: 7 [UPNP_DISCOVERY_SEARCH_TIMEOUT] [0x0] (recurse 0)
[10:59:40.005185] UpdateThread:692 Presence checking
[10:59:40.080422] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 1)
[10:59:40.083430] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 1)
[10:59:40.095281] UpdateThread:744 [0x12800a3c0] UPnP keep alive: Living Room+
[10:59:40.221298] GetMaster:102 Found Master RINCON_949F3E91E91201400 uuid:RINCON_000E58D4A64201400
[10:59:40.221314] UpdateThread:744 [0x128008000] UPnP keep alive: 192.168.2.25 - Sonos Sub+
[10:59:40.535555] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:59:40.537535] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:59:40.537887] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[10:59:40.567078] GetMaster:102 Found Master RINCON_949F3E91E91201400 uuid:RINCON_000E58D4A64201400
[10:59:40.567091] UpdateThread:744 [0x128008000] UPnP keep alive: 192.168.2.25 - Sonos Sub+
[10:59:40.647723] UpdateThread:744 [0x12800a3c0] UPnP keep alive: Living Room+
[10:59:40.709701] UpdateThread:744 [0x12800c780] UPnP keep alive: Office+
[10:59:41.272541] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:41.448415] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:59:42.289326] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:46.277603] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:46.453470] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:59:47.294383] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:51.282663] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:51.458527] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:59:52.299443] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[10:59:53.117251] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:59:53.129374] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:59:53.148887] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:59:53.149191] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:59:53.164823] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:59:53.165329] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:59:53.183383] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:59:53.183383] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:59:53.198437] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[10:59:56.287723] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[10:59:56.463587] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[10:59:57.300061] MRThread:241 [0x12800c780]: UPnP thread timer 5001 5000
[11:00:00.005155] MasterHandler:557 event: 7 [UPNP_DISCOVERY_SEARCH_TIMEOUT] [0x0] (recurse 0)
[11:00:00.005171] UpdateThread:692 Presence checking
[11:00:00.236805] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[11:00:00.266467] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[11:00:00.455483] UpdateThread:744 [0x12800a3c0] UPnP keep alive: Living Room+
[11:00:00.458414] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[11:00:00.524987] UpdateThread:744 [0x12800c780] UPnP keep alive: Office+
[11:00:00.565929] GetMaster:102 Found Master RINCON_949F3E91E91201400 uuid:RINCON_000E58D4A64201400
[11:00:00.565943] UpdateThread:744 [0x128008000] UPnP keep alive: 192.168.2.25 - Sonos Sub+
[11:00:01.292782] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[11:00:01.468650] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[11:00:02.305126] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[11:00:04.254047] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:06.297844] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[11:00:06.470615] MRThread:241 [0x12800a3c0]: UPnP thread timer 5002 5000
[11:00:07.310182] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[11:00:11.302902] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[11:00:11.473074] MRThread:241 [0x12800a3c0]: UPnP thread timer 5003 5000
[11:00:12.315243] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[11:00:16.307959] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[11:00:16.478134] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[11:00:17.319061] MRThread:241 [0x12800c780]: UPnP thread timer 5004 5000
[11:00:20.005156] MasterHandler:557 event: 7 [UPNP_DISCOVERY_SEARCH_TIMEOUT] [0x0] (recurse 0)
[11:00:20.005185] UpdateThread:692 Presence checking
[11:00:20.084293] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 1)
[11:00:20.102801] UpdateThread:744 [0x12800c780] UPnP keep alive: Office+
[11:00:20.374114] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[11:00:20.374426] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[11:00:20.419201] GetMaster:102 Found Master RINCON_949F3E91E91201400 uuid:RINCON_000E58D4A64201400
[11:00:20.419218] UpdateThread:744 [0x128008000] UPnP keep alive: 192.168.2.25 - Sonos Sub+
[11:00:20.481469] UpdateThread:744 [0x12800a3c0] UPnP keep alive: Living Room+
[11:00:20.529469] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[11:00:20.529892] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:20.572595] UpdateThread:744 [0x12800c780] UPnP keep alive: Office+
[11:00:20.607717] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:20.893953] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:21.044152] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:21.120454] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:21.313018] MRThread:241 [0x128008000]: UPnP thread timer 5006 5000
[11:00:21.483202] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[11:00:22.324122] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[11:00:26.318032] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[11:00:26.487966] MRThread:241 [0x12800a3c0]: UPnP thread timer 5004 5000
[11:00:27.329182] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[11:00:31.320530] MRThread:241 [0x128008000]: UPnP thread timer 5002 5000
[11:00:31.492876] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[11:00:32.334244] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[11:00:36.325590] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[11:00:36.497944] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[11:00:37.339303] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[11:00:40.005156] MasterHandler:557 event: 7 [UPNP_DISCOVERY_SEARCH_TIMEOUT] [0x0] (recurse 0)
[11:00:40.005184] UpdateThread:692 Presence checking
[11:00:40.382781] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[11:00:40.398831] UpdateThread:744 [0x12800a3c0] UPnP keep alive: Living Room+
[11:00:40.415908] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[11:00:40.449294] MasterHandler:557 event: 6 [UPNP_DISCOVERY_SEARCH_RESULT] [0x0] (recurse 0)
[11:00:40.460246] UpdateThread:744 [0x12800c780] UPnP keep alive: Office+
[11:00:40.496673] GetMaster:102 Found Master RINCON_949F3E91E91201400 uuid:RINCON_000E58D4A64201400
[11:00:40.496688] UpdateThread:744 [0x128008000] UPnP keep alive: 192.168.2.25 - Sonos Sub+
[11:00:41.329946] MRThread:241 [0x128008000]: UPnP thread timer 5004 5000
[11:00:41.503008] MRThread:241 [0x12800a3c0]: UPnP thread timer 5006 5000
[11:00:42.341493] MRThread:241 [0x12800c780]: UPnP thread timer 5002 5000
[11:00:43.860824] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:43.869188] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:44.077461] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:44.160419] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:44.544012] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
[11:00:46.335008] MRThread:241 [0x128008000]: UPnP thread timer 5006 5000
[11:00:46.508066] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[11:00:47.346566] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[11:00:51.339739] MRThread:241 [0x128008000]: UPnP thread timer 5004 5000
[11:00:51.513128] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[11:00:52.351644] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
[11:00:56.344802] MRThread:241 [0x128008000]: UPnP thread timer 5005 5000
[11:00:56.518189] MRThread:241 [0x12800a3c0]: UPnP thread timer 5005 5000
[11:00:57.356703] MRThread:241 [0x12800c780]: UPnP thread timer 5005 5000
^C[11:00:59.125421] Stop:1148 terminate update thread ...
[11:00:59.125464] Stop:1153 flush renderers ...
[11:00:59.125502] MRThread:241 [0x12800a3c0]: UPnP thread timer 2607 5000
[11:00:59.125509] MRThread:241 [0x12800c780]: UPnP thread timer 1769 5000
[11:00:59.157024] MRThread:241 [0x12800c780]: UPnP thread timer 32 5000
[11:01:00.005158] MasterHandler:557 event: 7 [UPNP_DISCOVERY_SEARCH_TIMEOUT] [0x0] (recurse 0)
[11:01:03.974980] MasterHandler:557 event: 4 [UPNP_DISCOVERY_ADVERTISEMENT_ALIVE] [0x0] (recurse 0)
^C[11:01:27.505659] Stop:1148 terminate update thread ...
[11:01:27.505698] Stop:1153 flush renderers ...
^C[11:01:30.564886] Stop:1148 terminate update thread ...
[11:01:30.564898] Stop:1153 flush renderers ...
^Z
zsh: suspended  ~/bin/airupnp-macos-arm64-static -d all=sdebug