98_UPNPController/98_DLNAController und VestelTVs

Begonnen von RockFan, 14 März 2021, 12:22:36

Vorheriges Thema - Nächstes Thema

KölnSolar

Hi Dieter,
ZitatTV und Radio sind von Medion ;D
;D ;D ;D
ZitatDie Radio-IP in ignoredIPs eintragen?
Genau. Ich glaube, dass das Radio generell zu Problemen beim subscription renewal führt. Und ich erkenne mehr/klarer.
ZitatSteuern konnte ich vom DLNAController gar nichts.
Eins nach dem anderen.  ;)
Grüße Markus
RPi3/2 buster/stretch-SamsungAV_E/N-RFXTRX-IT-RSL-NC5462-Oregon-CUL433-GT-TMBBQ-01e-CUL868-FS20-EMGZ-1W(GPIO)-DS18B20-CO2-USBRS232-USBRS422-Betty_Boop-EchoDot-OBIS(Easymeter-Q3/EMH-KW8)-PCA301(S'duino)-Deebot(mqtt2)-zigbee2mqtt

RockFan

Hi Markus,

hier mal wieder neue Testergebnisse:
Die IP des Radios hatte ich gestern Abend noch als ignoredIP aufgenommen:
ignoredIPs   192.168.178.58

Die IP des Radios finde ich aber noch im Log:

2021.03.27 11:36:09 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.27 11:36:09 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.27 11:36:09 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.27 11:36:09 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-RenderingControl, uniquedevice 192.168.178.58_8080, service RenderingControl



Die Testergebnisse zum TV sind in meinen Augen identisch zu vorher.

Ich habe sowohl mit dem DLNAController-Device, wie auch mit der FB herumgespielt. Änderungen mit dem DLNAController-Device haben sich nicht auf das TV-Gerät ausgewirkt und FB-Einstellungen wurden, mit der bekannten Ausnahme nach dem Einschalten des TVs, nicht im DLNAController-Device sichtbar.
Irrelevante Devices habe ich aus dem folgenden Log wieder entfernt, damit es übersichtlich bleibt  8)


2021.03.27 11:42:05 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceRemoved
2021.03.27 11:42:05 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, offline, urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.27 11:42:06 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceAdded
2021.03.27 11:42:06 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.03.27 11:42:06 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.03.27 11:42:06 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.27 11:42:06 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="21"/><VolumeDB channel="Master" val="-19005"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.03.27 11:42:06 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>

2021.03.27 11:42:16 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.03.27 11:42:54 4: UPNPController: RenderingControl, SetMute(0,Master,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"

2021.03.27 11:43:02 4: UPNPController: RenderingControl, SetMute(0,Master,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"

2021.03.27 11:43:07 4: UPNPController: RenderingControl, SetVolume(0,Master,48) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"

2021.03.27 11:43:16 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.27 11:43:21 4: UPNPController: RenderingControl, SetVolume(0,Master,6) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"

2021.03.27 11:43:38 4: UPNPController: RenderingControl, SetMute(0,Master,0) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorCode => 501, errorDescription => 'Action Failed'}}"

2021.03.27 11:44:16 4: UPNPController: AVTransport, Stop(0) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.03.27 11:44:16 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.27 11:44:16 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.27 11:44:16 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.27 11:44:16 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-AVTransport, uniquedevice 192.168.178.58_8080, service AVTransport
2021.03.27 11:44:26 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.03.27 11:45:04 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceRemoved
2021.03.27 11:45:04 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, offline, urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.27 11:45:05 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceAdded
2021.03.27 11:45:05 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.03.27 11:45:05 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.03.27 11:45:05 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.27 11:45:05 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.03.27 11:45:05 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.03.27 11:45:15 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.03.27 11:46:15 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.03.27 11:47:15 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.03.27 11:48:15 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.27 11:48:15 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.27 11:48:15 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.27 11:48:15 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-RenderingControl, uniquedevice 192.168.178.58_8080, service RenderingControl
2021.03.27 11:48:25 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.03.27 11:49:25 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.27 11:49:28 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.27 11:49:32 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.27 11:49:32 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.03.27 11:49:35 4: UPNPController: UPNP_Controller: uniqueDeviceName 192.168.178.61_2870 event offline not yet implemented
2021.03.27 11:49:35 3: UPNPController: subscription for service AVTransport of device 192.168.178.61_2870 failed:


Ich hoffe es bringt Dir neue Erkenntnisse :)

Viele Grüße
Dieter
Raspbian (Buster) auf Raspberry Pi 4 /  CUL + RFXTRX + TCM / FS20, FHT 80B, S300TH, Intertechno, DMX, Milight, EnOcean, Homematic, AMAD, Home Connect, MiSmartHome, Yeelight, ...

KölnSolar

Hi Dieter,
nicht wirklich.  :'(
Mach bitte mal ein modify beim UPNPController, sonst wirkt sich das Attribut nicht aus.
Morgen kommt eine neue Version, wo ein paar Fehler beseitigt sind. Betrifft Dich aber eher nicht. Hilft mir aber, weil ich sonst die Logauszüge nicht interpretieren kann.
Grüße
Markus
RPi3/2 buster/stretch-SamsungAV_E/N-RFXTRX-IT-RSL-NC5462-Oregon-CUL433-GT-TMBBQ-01e-CUL868-FS20-EMGZ-1W(GPIO)-DS18B20-CO2-USBRS232-USBRS422-Betty_Boop-EchoDot-OBIS(Easymeter-Q3/EMH-KW8)-PCA301(S'duino)-Deebot(mqtt2)-zigbee2mqtt

RockFan

Hallo Markus,
mit dem modify-Kommando bin ich ehrlich gesagt nicht vertraut. Ich habe mal
modify UPNP_Controller
aufgerufen, bin aber nicht sicher, ob du das gemeint hast.

Jedenfalls gibt es jetzt einige neue Logeinträge, ohne irgendwelche Tests gemacht zu haben:


2021.03.28 12:18:08 4: DLNAController: message parameters: AVTransport, 192.168.178.88_1360, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><CurrentPlayMode val="NORMAL"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><CurrentTrackURI val="/var/run/lirc/lircd"/><CurrentTrackDuration val="00:00:00"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><CurrentMediaDuration val="00:00:00"/><AVTransportURI val="/var/run/lirc/lircd"/><TransportState val="STOPPED"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot; xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:dlna=&quot;urn:schemas-dlna-org:metadata-1-0/&quot; xmlns:sec=&quot;http://www.sec.co.kr/&quot; xmlns:xbmc=&quot;urn:schemas-xbmc-org:metadata-1-0/&quot;>&lt;item id=&quot;/var/run/lirc/lircd&quot; parentID=&quot;&quot; restricted=&quot;1&quot;>&lt;dc:title>/var/run/lirc/lircd&lt;/dc:title>&lt;dc:creator>Unknown&lt;/dc:creator>&lt;dc:publisher>Unknown&lt;/dc:publisher>&lt;upnp:genre>Unknown&lt;/upnp:genre>&lt;upnp:albumArtURI dlna:profileID=&quot;JPEG_TN&quot;>http://192.168.178.88:1360/thumb?path=image%3A%2F%2F&lt;/upnp:albumArtURI>&lt;upnp:episodeSeason>0&lt;/upnp:episodeSeason>&lt;xbmc:rating>0.0&lt;/xbmc:rating>&lt;xbmc:userrating>0&lt;/xbmc:userrating>&lt;upnp:class>object.item&lt;/upnp:class>&lt;/item>&lt;/DIDL-Lite>"/><NextAVTransportURI val=""/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><CurrentTrack val="0"/><NextAVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentTransportActions val="Play,Pause,Stop,Seek,Next,Previous"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><PossiblePlaybackStorageMedia val="NONE,NETWORK,HDD,CD-DA,UNKNOWN"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot; xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:dlna=&quot;urn:schemas-dlna-org:metadata-1-0/&quot; xmlns:sec=&quot;http://www.sec.co.kr/&quot; xmlns:xbmc=&quot;urn:schemas-xbmc-org:metadata-1-0/&quot;>&lt;item id=&quot;/var/run/lirc/lircd&quot; parentID=&quot;&quot; restricted=&quot;1&quot;>&lt;dc:title>/var/run/lirc/lircd&lt;/dc:title>&lt;dc:creator>Unknown&lt;/dc:creator>&lt;dc:publisher>Unknown&lt;/dc:publisher>&lt;upnp:genre>Unknown&lt;/upnp:genre>&lt;upnp:albumArtURI dlna:profileID=&quot;JPEG_TN&quot;>http://192.168.178.88:1360/thumb?path=image%3A%2F%2F&lt;/upnp:albumArtURI>&lt;upnp:episodeSeason>0&lt;/upnp:episodeSeason>&lt;xbmc:rating>0.0&lt;/xbmc:rating>&lt;xbmc:userrating>0&lt;/xbmc:userrating>&lt;upnp:class>object.item&lt;/upnp:class>&lt;/item>&lt;/DIDL-Lite>"/><NumberOfTracks val="0"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/></InstanceID></Event>
2021.03.28 12:18:09 4: UPNPController: discovery message of Kodi (Raspi-Wohnzimmer) with UDN: uuid:4b857181-b27b-fcdb-87bf-1db1de79cdc0 action: deviceAdded
2021.03.28 12:18:09 4: DLNAController: message parameters: RenderingControl, 192.168.178.88_1360, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume Channel="Master" val="100"/><Mute Channel="Master" val="0"/><PresetNameList val="FactoryDefaults"/><VolumeDB Channel="Master" val="0"/></InstanceID></Event>
2021.03.28 12:18:09 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.03.28 12:18:09 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.03.28 12:18:09 4: UPNPController: UPNP_Controller: uniqueDeviceName 192.168.178.35_8888 event offline not yet implemented
2021.03.28 12:18:09 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.03.28 12:18:09 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.28 12:18:09 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.28 12:18:09 4: UPNPController: discovery message of nas-server with UDN: uuid:55076f6e-6b79-4d65-64d4-00114132c6f5 action: deviceAdded
2021.03.28 12:18:09 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.28 12:18:09 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.28 12:18:09 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-AVTransport, uniquedevice 192.168.178.58_8080, service AVTransport
2021.03.28 12:18:09 1: ERROR evaluating {UPNPController_renewSubscriptionsfinished('UPNP_Controller|192.168.178.58_8080-zs-AVTransport')}: Can't call method "timeout" on an undefined value at ./FHEM/98_UPNPController.pm line 725.

2021.03.28 12:18:34 4: UPNPController: discovery message of MiniDLNA OMV with UDN: uuid:4d696e69-444c-164e-9d41-dca6323a2861 action: deviceAdded
2021.03.28 12:18:34 4: UPNPController: discovery message of MP2-Server with UDN: uuid:7751031a-1072-4dfb-a70b-4efa48847dc4 action: deviceAdded

2021.03.28 12:19:11 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.28 12:19:11 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: Can't call method "renew" on unblessed reference at ./FHEM/98_UPNPController.pm line 786.
, try to subscribe
2021.03.28 12:19:12 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-AVTransport, uniquedevice 192.168.178.58_8080, service AVTransport
2021.03.28 12:19:12 1: ERROR evaluating {UPNPController_renewSubscriptionsfinished('UPNP_Controller|192.168.178.58_8080-zs-AVTransport')}: Can't call method "timeout" on an undefined value at ./FHEM/98_UPNPController.pm line 725.


2021.03.28 12:20:14 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.28 12:20:14 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: Can't call method "renew" on unblessed reference at ./FHEM/98_UPNPController.pm line 786.
, try to subscribe


Ansonsten warte ich mal auf die neue Version ;)

Viele Grüße
Dieter
Raspbian (Buster) auf Raspberry Pi 4 /  CUL + RFXTRX + TCM / FS20, FHT 80B, S300TH, Intertechno, DMX, Milight, EnOcean, Homematic, AMAD, Home Connect, MiSmartHome, Yeelight, ...

KölnSolar

Hi Dieter,
Zitatmit dem modify-Kommando bin ich ehrlich gesagt nicht vertraut
In dem Fall hast Du gemacht, was ich meinte/bezweckte.  :) Grundsätzlich kannst Du über den Webbrowser in der Detailansicht bei den Internals auf "DEF" klicken. Unter dem sich öffnenden Fenster steht dann "modify....". Dort klickt man dann wieder auf modify. Fertig.

Zitatjetzt einige neue Logeinträge
In der Regel alles neue Geräte....

Das Radio taucht leider immer noch auf.  :'( Da musst Du noch auf die neue Version warten, um den nächsten Schritt(löschen der readings im UPNPController) zu machen.

ZitatAnsonsten warte ich mal auf die neue Version
Zieht sich leider, weil ich im Augenblick mehr mit meiner defekten Garagentorsteuerung beschäftigt bin: Ersatz eines defekten ICs durch einen selbstprogrammierten attiny.

Grüße Markus
RPi3/2 buster/stretch-SamsungAV_E/N-RFXTRX-IT-RSL-NC5462-Oregon-CUL433-GT-TMBBQ-01e-CUL868-FS20-EMGZ-1W(GPIO)-DS18B20-CO2-USBRS232-USBRS422-Betty_Boop-EchoDot-OBIS(Easymeter-Q3/EMH-KW8)-PCA301(S'duino)-Deebot(mqtt2)-zigbee2mqtt

RockFan

Hi Markus,

ZitatGrundsätzlich kannst Du über den Webbrowser in der Detailansicht bei den Internals auf "DEF" klicken. Unter dem sich öffnenden Fenster steht dann "modify....".
Diesen Weg verwende ich regelmäßig  ;)

ZitatZieht sich leider,
Keine Eile  8)

Viele Grüße
Dieter
Raspbian (Buster) auf Raspberry Pi 4 /  CUL + RFXTRX + TCM / FS20, FHT 80B, S300TH, Intertechno, DMX, Milight, EnOcean, Homematic, AMAD, Home Connect, MiSmartHome, Yeelight, ...

KölnSolar

Hallo Dieter,

ich hab neue Versionen attached. Ich habe dabei die Absturzursache beim Löschen von readings beseitigt. Du kannst nach einem reload nun also ein set UPNP_Controller delreadings 192.168.178.58_8080machen u. dann sollten wir das Radio los sein und uns auf den TV konzentrieren können.

Grüße Markus
RPi3/2 buster/stretch-SamsungAV_E/N-RFXTRX-IT-RSL-NC5462-Oregon-CUL433-GT-TMBBQ-01e-CUL868-FS20-EMGZ-1W(GPIO)-DS18B20-CO2-USBRS232-USBRS422-Betty_Boop-EchoDot-OBIS(Easymeter-Q3/EMH-KW8)-PCA301(S'duino)-Deebot(mqtt2)-zigbee2mqtt

RockFan

#22
Hallo Markus,

Danke für die Bemühungen :)

Das Radio sind wir jetzt tatsächlich los. Es gibt meiner Ansicht nach mit den neuen Versionen deutlich mehr Logeinträge (verbose ist immer noch 4). Hier mal ein Auszug vor den TV-Tests:


2021.04.02 11:16:26 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:26 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:26 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:26 3: UPNPController: start searching by type with search term: upnp:rootdevice
2021.04.02 11:16:26 3: UPNPController: start searching by type with search term: upnp:rootdevice
2021.04.02 11:16:26 4: UPNPController: SpeakerManagement unknown for UPNP_Controller.
2021.04.02 11:16:26 4: UPNPController: UPNP_Controller, iowrite message received, but service SpeakerManagement not implemented
2021.04.02 11:16:26 4: UPNPController: SessionManagement unknown for UPNP_Controller.
2021.04.02 11:16:26 4: UPNPController: UPNP_Controller, iowrite message received, but service SessionManagement not implemented
2021.04.02 11:16:26 3: DLNAController: DLNA_024c7600_fc76_0074_b24e_0038fc74c4b0 address changed; services initially subscribed
2021.04.02 11:16:26 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:26 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:26 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:26 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:26 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:26 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:26 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:26 4: UPNPController: discovery message of BUWODach with UDN: uuid:123402409-bccb-40e7-8e6c-3810D5F58E68 action: deviceAdded
2021.04.02 11:16:26 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:26 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:26 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:26 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:26 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:26 4: UPNPController: discovery message of AVM FRITZ!Mediaserver with UDN: uuid:fa095ecc-e13e-40e7-8e6c-444e6d5b9ecd action: deviceAdded
2021.04.02 11:16:26 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:26 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:26 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:26 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:26 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:26 4: UPNPController: discovery message of BUWOEssplatz with UDN: uuid:123402409-bccb-40e7-8e6c-3810D5023B0A action: deviceAdded
2021.04.02 11:16:26 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:26 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:26 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:26 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:26 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:26 4: UPNPController: discovery message of FRITZ!Box 7590 (UI) with UDN: uuid:123402409-bccb-40e7-8e6c-444E6D5B9ECD action: deviceAdded
2021.04.02 11:16:26 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:26 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:26 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:26 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:26 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:27 4: UPNPController: discovery message of InternetGatewayDeviceV2 - FRITZ!Box 7590 (UI) with UDN: uuid:75802409-bccb-40e7-9f6c-444E6D5B9ECD action: deviceAdded
2021.04.02 11:16:27 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:27 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:27 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:27 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:27 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:27 4: UPNPController: discovery message of MiniDLNA OMV with UDN: uuid:4d696e69-444c-164e-9d41-dca6323a2861 action: deviceAdded
2021.04.02 11:16:27 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:27 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:27 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:27 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:27 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:27 4: UPNPController: discovery message of FRITZ!Box 7590 (UI) with UDN: uuid:75802409-bccb-40e7-8e6c-444E6D5B9ECD action: deviceAdded
2021.04.02 11:16:27 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:27 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:27 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:27 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:27 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:27 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:27 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:27 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:27 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:27 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:27 4: UPNPController: discovery message of FRITZ!Box 7590 (UI) with UDN: uuid:95802409-bccb-40e7-8e6c-444E6D5B9ECD action: deviceAdded
2021.04.02 11:16:28 4: UPNPController: discovery message of FRITZ!Box 7590 (UI) with UDN: uuid:535502409-bccb-40e7-8e6c-444E6D5B9ECD action: deviceAdded
2021.04.02 11:16:28 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:28 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:28 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:28 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:28 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:28 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:28 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:28 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:28 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:28 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:16:28 4: UPNPController: discovery message of nas-server with UDN: uuid:55076f6e-6b79-4d65-64d4-00114132c6f5 action: deviceAdded
2021.04.02 11:16:37 4: UPNPController: discovery message of Jellyfin - MediaNAS with UDN: uuid:1a1c5a4be39a463781c3b63d5569ce56 action: deviceAdded
2021.04.02 11:16:37 4: UPNPController: discovery message of TX-NR414 with UDN: uuid:024c7600-fc76-0074-b24e-0038fc74c4b0 action: deviceAdded
2021.04.02 11:16:37 4: UPNPController: subscribe: reading  192.168.178.35_8888-zs-RenderingControl, uniquedevice 192.168.178.35_8888, service RenderingControl
2021.04.02 11:16:37 4: DLNAController: message parameters: RenderingControl, 192.168.178.35_8888, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.02 11:16:37 3: UPNPController: subscription for service RenderingControl of device 192.168.178.35_8888 failed:
2021.04.02 11:16:37 4: DLNAController: message parameters: AVTransport, 192.168.178.35_8888, online, urn:schemas-upnp-org:metadata-1-0/AVT


V.a. für den Onkyo Receiver (192.168.178.35) sehe ich viele Einträge.

Der Test des TVs ist aus Benutzersicht leider identisch zu bisher verlaufen. Über den DLNAController lässt sich nicht beeinflussen und sichtbar wird eine Lautstärkeänderung nur nach dem Einschalten.

Neben der Lautstärke (inkl. Mute) habe ich auch kurzentschlossen vom Smartphone aus einen Musikstream geschickt. Das sehe ich sogar im DLNAController. Das ist mir aber auf meinem Tablet nicht sofort aufgefallen. Da currentArtist noch den Interpreten von einem vergangenen Stream anzeigen (Readingdate vom 21.3.) vermute ich, dass es da auch schon funktioniert hat und mir nur nicht aufgefallen ist :-[

Hier nun noch die Logs zum Test:


2021.04.02 11:24:43 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceAdded
2021.04.02 11:24:43 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.04.02 11:24:43 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl timeout: 300
2021.04.02 11:24:43 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.04.02 11:24:43 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport timeout: 300
2021.04.02 11:24:43 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:24:43 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.02 11:24:43 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.02 11:24:53 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.04.02 11:25:11 4: UPNPController: RenderingControl, SetVolume(0,Master,14) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorCode => 501, errorDescription => 'Action Failed'}}"

2021.04.02 11:25:19 4: UPNPController: RenderingControl, SetMute(0,Master,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorCode => 501, errorDescription => 'Action Failed'}}"

2021.04.02 11:25:36 4: UPNPController: RenderingControl, SetMute(0,Master,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorCode => 501, errorDescription => 'Action Failed'}}"
2021.04.02 11:25:42 4: UPNPController: RenderingControl, SetVolume(0,Master,0) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.02 11:25:53 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.04.02 11:26:53 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.04.02 11:27:53 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.04.02 11:28:53 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.04.02 11:28:58 3: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.61_2870 failed: , try to subscribe
2021.04.02 11:29:03 3: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.61_2870 failed: , try to subscribe
2021.04.02 11:29:03 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.04.02 11:29:04 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceRemoved
2021.04.02 11:29:04 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, offline, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:29:04 3: UPNPController: start searching by type with search term: upnp:rootdevice
2021.04.02 11:29:04 3: UPNPController: start searching by type with search term: upnp:rootdevice
2021.04.02 11:29:04 4: UPNPController: SpeakerManagement unknown for UPNP_Controller.
2021.04.02 11:29:04 4: UPNPController: UPNP_Controller, iowrite message received, but service SpeakerManagement not implemented
2021.04.02 11:29:04 4: UPNPController: SessionManagement unknown for UPNP_Controller.
2021.04.02 11:29:04 4: UPNPController: UPNP_Controller, iowrite message received, but service SessionManagement not implemented
2021.04.02 11:29:04 3: DLNAController: DLNA_13cae598_3cca_165a_8000_0009dfbd33fb address changed; services initially subscribed
2021.04.02 11:29:04 1: ERROR evaluating {UPNPController_renewSubscriptionsfinished('UPNP_Controller|192.168.178.61_2870-zs-RenderingControl')}: Can't call method "deviceRemoved" on an undefined value at FHEM/lib/UPnP/ControlPoint.pm line 436.


2021.04.02 11:29:34 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceAdded
2021.04.02 11:29:34 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.04.02 11:29:35 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl timeout: 300
2021.04.02 11:29:35 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.04.02 11:29:35 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport timeout: 300
2021.04.02 11:29:35 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.02 11:29:35 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="4"/><VolumeDB channel="Master" val="-30146"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.02 11:29:35 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.02 11:29:42 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.mp3"/><NumberOfTracks val="1"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;The Harder They Come&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;220 Volt&lt;/upnp:artist&gt;&lt;upnp:album&gt;Eye To Eye (Remastered)&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Hair Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2003-01-01&lt;/dc:date&gt;&lt;res size=&quot;5537792&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><PlaybackStorageMedium val="NETWORK"/><CurrentMediaCategory val="TRACK_AWARE"/><TransportState val="STOPPED"/><CurrentTrack val="1"/><CurrentTrackDuration val="0:00:00.000"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;The Harder They Come&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;220 Volt&lt;/upnp:artist&gt;&lt;upnp:album&gt;Eye To Eye (Remastered)&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Hair Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2003-01-01&lt;/dc:date&gt;&lt;res size=&quot;5537792&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.mp3"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.02 11:29:43 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentTrackDuration val="64:10:00.000"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
2021.04.02 11:29:45 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800


Viele Grüße
Dieter
Raspbian (Buster) auf Raspberry Pi 4 /  CUL + RFXTRX + TCM / FS20, FHT 80B, S300TH, Intertechno, DMX, Milight, EnOcean, Homematic, AMAD, Home Connect, MiSmartHome, Yeelight, ...

KölnSolar

Hi Dieter,
ZitatDas Radio sind wir jetzt tatsächlich los
wenigstens etwas.
ZitatOnkyo Receiver
Noch ein device mit seltsamem Verhalten.  :o ::)

ZitatNeben der Lautstärke (inkl. Mute) habe ich auch kurzentschlossen vom Smartphone aus einen Musikstream geschickt.
seh ich2021.04.02 11:29:42 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.mp3"/><NumberOfTracks val="1"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;The Harder They Come&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;220 Volt&lt;/upnp:artist&gt;&lt;upnp:album&gt;Eye To Eye (Remastered)&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Hair Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2003-01-01&lt;/dc:date&gt;&lt;res size=&quot;5537792&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><PlaybackStorageMedium val="NETWORK"/><CurrentMediaCategory val="TRACK_AWARE"/><TransportState val="STOPPED"/><CurrentTrack val="1"/><CurrentTrackDuration val="0:00:00.000"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;The Harder They Come&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;220 Volt&lt;/upnp:artist&gt;&lt;upnp:album&gt;Eye To Eye (Remastered)&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Hair Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2003-01-01&lt;/dc:date&gt;&lt;res size=&quot;5537792&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Rock/220%20Volt%20-%20The%20Harder%20They%20Come.mp3"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.02 11:29:43 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentTrackDuration val="64:10:00.000"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
Womit sich meine alte Spekulation bestätigt: ca. 5' bekommst Du eine Rückmeldung. Aber dann ist Schluss, weil
Zitat2021.04.02 11:29:03 3: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.61_2870 failed: , try to subscribe
2021.04.02 11:29:03 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.04.02 11:29:04 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceRemoved
2021.04.02 11:29:04 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, offline, urn:schemas-upnp-org:metadata-1-0/AVT
An der Stelle bräuchte ich dann ein verbose=5. Vielleicht erkenne ich den Grund.

Aber probier als Erstes mal line 778 die 1800 in 300 zu ändern. Könnte sein, dass er das nicht mag, andere devices toleranter sind.

Grüße Markus



RPi3/2 buster/stretch-SamsungAV_E/N-RFXTRX-IT-RSL-NC5462-Oregon-CUL433-GT-TMBBQ-01e-CUL868-FS20-EMGZ-1W(GPIO)-DS18B20-CO2-USBRS232-USBRS422-Betty_Boop-EchoDot-OBIS(Easymeter-Q3/EMH-KW8)-PCA301(S'duino)-Deebot(mqtt2)-zigbee2mqtt

RockFan

#24
Hallo Markus,

ich habe den Timeout runtergesetzt (danach natürlich ein reload) und auch verbose auf 5 gesetzt (UPNPController). Meiner Einschätzung nach (aus User-Sicht) hat sich nichts geändert.

Hier wieder die Logs:


2021.04.03 11:47:51 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300

2021.04.03 11:48:03 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.04.03 11:48:03 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.04.03 11:48:03 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.04.03 11:48:10 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceAdded
2021.04.03 11:48:10 5: UPNPController: UPNP_Controller: alive-notify message device uuid:13cae598-3cca-165a-8000-0009dfbd33fb received
2021.04.03 11:48:10 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 547.

2021.04.03 11:48:10 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb found. Check for processing
2021.04.03 11:48:10 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb will be controlled with 192.168.178.61_2870
2021.04.03 11:48:10 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: RenderingControl
2021.04.03 11:48:10 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.04.03 11:48:10 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 11:48:10 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 11:48:11 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl timeout: 300
2021.04.03 11:48:11 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: ConnectionManager
2021.04.03 11:48:11 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: AVTransport
2021.04.03 11:48:11 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.04.03 11:48:11 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 11:48:11 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 11:48:11 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport timeout: 300
2021.04.03 11:48:11 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 11:48:11 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 11:48:11 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 11:48:11 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xa450ee0) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/RCS/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;Mute channel=&quot;Master&quot; val=&quot;0&quot;/&gt;&lt;Volume channel=&quot;Master&quot; val=&quot;20&quot;/&gt;&lt;VolumeDB channel=&quot;Master&quot; val=&quot;-19661&quot;/&gt;&lt;PresetNameList val=&quot;FactoryDefaults&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 11:48:11 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 11:48:11 5: UPNP_Controller: dispatch RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 11:48:11 5: DLNAController: message from UPNP_Controller, message: RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 11:48:11 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 11:48:11 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xa6d2870) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/AVT/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;AVTransportURI val=&quot;&quot;/&gt;&lt;NumberOfTracks val=&quot;0&quot;/&gt;&lt;AVTransportURIMetaData val=&quot;&quot;/&gt;&lt;PlaybackStorageMedium val=&quot;NONE&quot;/&gt;&lt;CurrentMediaCategory val=&quot;NO_MEDIA&quot;/&gt;&lt;PossiblePlaybackStorageMedia val=&quot;NONE,NETWORK&quot;/&gt;&lt;RecordStorageMedium val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;PossibleRecordStorageMedia val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;RecordMediumWriteStatus val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;NextAVTransportURI val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;NextAVTransportURIMetaData val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;CurrentPlayMode val=&quot;NORMAL&quot;/&gt;&lt;CurrentRecordQualityMode val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;PossibleRecordQualityModes val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;TransportState val=&quot;NO_MEDIA_PRESENT&quot;/&gt;&lt;TransportStatus val=&quot;OK&quot;/&gt;&lt;TransportPlaySpeed val=&quot;1&quot;/&gt;&lt;CurrentTrack val=&quot;0&quot;/&gt;&lt;CurrentTrackDuration val=&quot;00:00:00&quot;/&gt;&lt;CurrentTrackMetaData val=&quot;&quot;/&gt;&lt;CurrentTrackURI val=&quot;&quot;/&gt;&lt;CurrentMediaDuration val=&quot;00:00:00&quot;/&gt;&lt;CurrentTransportActions val=&quot;&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 11:48:11 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 11:48:11 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 11:48:11 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 11:48:11 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 11:48:21 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300

2021.04.03 11:49:21 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300
2021.04.03 11:49:32 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, SetVolume, 0 Master 20
2021.04.03 11:49:32 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 11:49:32 4: UPNPController: RenderingControl, SetVolume(0,Master,20) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 11:49:33 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, SetVolume, 0 Master 6
2021.04.03 11:49:33 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 11:49:33 4: UPNPController: RenderingControl, SetVolume(0,Master,6) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 11:49:39 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.04.03 11:49:39 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.04.03 11:49:39 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.04.03 11:50:03 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.04.03 11:50:03 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.04.03 11:50:03 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.04.03 11:50:08 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, SetMute, 0 Master 0
2021.04.03 11:50:08 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 11:50:08 4: UPNPController: RenderingControl, SetMute(0,Master,0) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 11:50:13 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, SetMute, 0 Master 0
2021.04.03 11:50:13 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 11:50:13 4: UPNPController: RenderingControl, SetMute(0,Master,0) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorCode => 501, errorDescription => 'Action Failed'}}"
2021.04.03 11:50:18 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, SetMute, 0 Master 0
2021.04.03 11:50:18 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 11:50:18 4: UPNPController: RenderingControl, SetMute(0,Master,0) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 11:50:21 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300

2021.04.03 11:51:18 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceRemoved
2021.04.03 11:51:18 5: UPNPController: UPNP_Controller: byebye-notify message device 192.168.178.61_2870 received
2021.04.03 11:51:18 5: UPNPController: earlier subscribed service AVTransport of device 192.168.178.61_2870 went offline
2021.04.03 11:51:18 5: UPNPController: earlier subscribed service RenderingControl of device 192.168.178.61_2870 went offline
2021.04.03 11:51:18 5: UPNP_Controller: dispatch RenderingControl|192.168.178.61_2870|offline|urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.03 11:51:18 5: DLNAController: message from UPNP_Controller, message: RenderingControl|192.168.178.61_2870|offline|urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.03 11:51:18 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.04.03 11:51:19 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceAdded
2021.04.03 11:51:19 5: UPNPController: UPNP_Controller: alive-notify message device uuid:13cae598-3cca-165a-8000-0009dfbd33fb received
2021.04.03 11:51:19 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 547.

2021.04.03 11:51:19 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb found. Check for processing
2021.04.03 11:51:19 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb will be controlled with 192.168.178.61_2870
2021.04.03 11:51:19 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: RenderingControl
2021.04.03 11:51:19 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.04.03 11:51:19 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 11:51:19 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 11:51:19 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl timeout: 300
2021.04.03 11:51:19 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: ConnectionManager
2021.04.03 11:51:19 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: AVTransport
2021.04.03 11:51:19 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.04.03 11:51:19 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 11:51:19 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 11:51:19 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport timeout: 300
2021.04.03 11:51:19 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 11:51:19 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 11:51:19 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 11:51:19 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xa442480) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/RCS/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;Mute channel=&quot;Master&quot; val=&quot;0&quot;/&gt;&lt;Volume channel=&quot;Master&quot; val=&quot;0&quot;/&gt;&lt;VolumeDB channel=&quot;Master&quot; val=&quot;-32768&quot;/&gt;&lt;PresetNameList val=&quot;FactoryDefaults&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 11:51:19 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 11:51:19 5: UPNP_Controller: dispatch RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 11:51:19 5: DLNAController: message from UPNP_Controller, message: RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 11:51:19 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 11:51:20 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xa436268) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/AVT/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;AVTransportURI val=&quot;&quot;/&gt;&lt;NumberOfTracks val=&quot;0&quot;/&gt;&lt;AVTransportURIMetaData val=&quot;&quot;/&gt;&lt;PlaybackStorageMedium val=&quot;NONE&quot;/&gt;&lt;CurrentMediaCategory val=&quot;NO_MEDIA&quot;/&gt;&lt;PossiblePlaybackStorageMedia val=&quot;NONE,NETWORK&quot;/&gt;&lt;RecordStorageMedium val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;PossibleRecordStorageMedia val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;RecordMediumWriteStatus val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;NextAVTransportURI val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;NextAVTransportURIMetaData val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;CurrentPlayMode val=&quot;NORMAL&quot;/&gt;&lt;CurrentRecordQualityMode val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;PossibleRecordQualityModes val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;TransportState val=&quot;NO_MEDIA_PRESENT&quot;/&gt;&lt;TransportStatus val=&quot;OK&quot;/&gt;&lt;TransportPlaySpeed val=&quot;1&quot;/&gt;&lt;CurrentTrack val=&quot;0&quot;/&gt;&lt;CurrentTrackDuration val=&quot;00:00:00&quot;/&gt;&lt;CurrentTrackMetaData val=&quot;&quot;/&gt;&lt;CurrentTrackURI val=&quot;&quot;/&gt;&lt;CurrentMediaDuration val=&quot;00:00:00&quot;/&gt;&lt;CurrentTransportActions val=&quot;&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 11:51:20 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 11:51:20 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 11:51:20 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 11:51:20 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 11:51:21 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300

2021.04.03 11:52:03 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.04.03 11:52:03 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.04.03 11:52:03 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.04.03 11:52:21 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300
2021.04.03 11:52:39 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.04.03 11:52:39 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.04.03 11:52:39 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.04.03 11:53:21 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300
2021.04.03 11:53:54 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, SetVolume, 0 Master 18
2021.04.03 11:53:54 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 11:53:55 4: UPNPController: RenderingControl, SetVolume(0,Master,18) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 11:54:03 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.04.03 11:54:03 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.04.03 11:54:03 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.04.03 11:54:21 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300

2021.04.03 11:55:21 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300
2021.04.03 11:55:21 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.61_2870
2021.04.03 11:55:21 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 790.

2021.04.03 11:55:21 3: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.61_2870 failed: , try to subscribe
2021.04.03 11:55:21 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.61_2870
2021.04.03 11:55:21 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 790.

2021.04.03 11:55:21 3: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.61_2870 failed: , try to subscribe
2021.04.03 11:55:21 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.61_2870-zs-AVTransport
2021.04.03 11:55:21 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.04.03 11:55:21 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 11:55:21 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 11:55:21 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport timeout: 300
2021.04.03 11:55:21 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xa436268) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/AVT/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;AVTransportURI val=&quot;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&quot;/&gt;&lt;NumberOfTracks val=&quot;1&quot;/&gt;&lt;AVTransportURIMetaData val=&quot;&amp;lt;DIDL-Lite xmlns:dc=&amp;quot;http://purl.org/dc/elements/1.1/&amp;quot; xmlns:upnp=&amp;quot;urn:schemas-upnp-org:metadata-1-0/upnp/&amp;quot; xmlns=&amp;quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&amp;quot;&amp;gt;&amp;lt;item id=&amp;quot;0&amp;quot; restricted=&amp;quot;1&amp;quot;&amp;gt;&amp;lt;upnp:class&amp;gt;object.item.audioItem.musicTrack&amp;lt;/upnp:class&amp;gt;&amp;lt;dc:title&amp;gt;Röschenhof&amp;lt;/dc:title&amp;gt;&amp;lt;upnp:artist role=&amp;quot;albumArtist&amp;quot;&amp;gt;A.O.K.&amp;lt;/upnp:artist&amp;gt;&amp;lt;upnp:album&amp;gt;Dreilochbegehbar und Herrenrundentauglich&amp;lt;/upnp:album&amp;gt;&amp;lt;upnp:albumArtURI&amp;gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.jpg&amp;lt;/upnp:albumArtURI&amp;gt;&amp;lt;upnp:genre&amp;gt;Metal&amp;lt;/upnp:genre&amp;gt;&amp;lt;dc:date&amp;gt;2006-01-01&amp;lt;/dc:date&amp;gt;&amp;lt;res size=&amp;quot;3041126&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot;&amp;gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&amp;lt;/res&amp;gt;&amp;lt;/item&amp;gt;&amp;lt;/DIDL-Lite&amp;gt;&quot;/&gt;&lt;PlaybackStorageMedium val=&quot;NETWORK&quot;/&gt;&lt;CurrentMediaCategory val=&quot;TRACK_AWARE&quot;/&gt;&lt;PossiblePlaybackStorageMedia val=&quot;NONE,NETWORK&quot;/&gt;&lt;RecordStorageMedium val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;PossibleRecordStorageMedia val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;RecordMediumWriteStatus val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;NextAVTransportURI val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;NextAVTransportURIMetaData val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;CurrentPlayMode val=&quot;NORMAL&quot;/&gt;&lt;CurrentRecordQualityMode val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;PossibleRecordQualityModes val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;TransportState val=&quot;STOPPED&quot;/&gt;&lt;TransportStatus val=&quot;OK&quot;/&gt;&lt;TransportPlaySpeed val=&quot;1&quot;/&gt;&lt;CurrentTrack val=&quot;1&quot;/&gt;&lt;CurrentTrackDuration val=&quot;0:00:00.000&quot;/&gt;&lt;CurrentTrackMetaData val=&quot;&amp;lt;DIDL-Lite xmlns:dc=&amp;quot;http://purl.org/dc/elements/1.1/&amp;quot; xmlns:upnp=&amp;quot;urn:schemas-upnp-org:metadata-1-0/upnp/&amp;quot; xmlns=&amp;quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&amp;quot;&amp;gt;&amp;lt;item id=&amp;quot;0&amp;quot; restricted=&amp;quot;1&amp;quot;&amp;gt;&amp;lt;upnp:class&amp;gt;object.item.audioItem.musicTrack&amp;lt;/upnp:class&amp;gt;&amp;lt;dc:title&amp;gt;Röschenhof&amp;lt;/dc:title&amp;gt;&amp;lt;upnp:artist role=&amp;quot;albumArtist&amp;quot;&amp;gt;A.O.K.&amp;lt;/upnp:artist&amp;gt;&amp;lt;upnp:album&amp;gt;Dreilochbegehbar und Herrenrundentauglich&amp;lt;/upnp:album&amp;gt;&amp;lt;upnp:albumArtURI&amp;gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.jpg&amp;lt;/upnp:albumArtURI&amp;gt;&amp;lt;upnp:genre&amp;gt;Metal&amp;lt;/upnp:genre&amp;gt;&amp;lt;dc:date&amp;gt;2006-01-01&amp;lt;/dc:date&amp;gt;&amp;lt;res size=&amp;quot;3041126&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot;&amp;gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&amp;lt;/res&amp;gt;&amp;lt;/item&amp;gt;&amp;lt;/DIDL-Lite&amp;gt;&quot;/&gt;&lt;CurrentTrackURI val=&quot;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&quot;/&gt;&lt;CurrentMediaDuration val=&quot;0:00:00.000&quot;/&gt;&lt;CurrentTransportActions val=&quot;Play,Stop&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 11:55:21 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3"/><NumberOfTracks val="1"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;Röschenhof&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;A.O.K.&lt;/upnp:artist&gt;&lt;upnp:album&gt;Dreilochbegehbar und Herrenrundentauglich&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2006-01-01&lt;/dc:date&gt;&lt;res size=&quot;3041126&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><PlaybackStorageMedium val="NETWORK"/><CurrentMediaCategory val="TRACK_AWARE"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="STOPPED"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="1"/><CurrentTrackDuration val="0:00:00.000"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;Röschenhof&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;A.O.K.&lt;/upnp:artist&gt;&lt;upnp:album&gt;Dreilochbegehbar und Herrenrundentauglich&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2006-01-01&lt;/dc:date&gt;&lt;res size=&quot;3041126&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3"/><CurrentMediaDuration val="0:00:00.000"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.03 11:55:21 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3"/><NumberOfTracks val="1"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;Röschenhof&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;A.O.K.&lt;/upnp:artist&gt;&lt;upnp:album&gt;Dreilochbegehbar und Herrenrundentauglich&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2006-01-01&lt;/dc:date&gt;&lt;res size=&quot;3041126&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><PlaybackStorageMedium val="NETWORK"/><CurrentMediaCategory val="TRACK_AWARE"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="STOPPED"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="1"/><CurrentTrackDuration val="0:00:00.000"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;Röschenhof&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;A.O.K.&lt;/upnp:artist&gt;&lt;upnp:album&gt;Dreilochbegehbar und Herrenrundentauglich&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2006-01-01&lt;/dc:date&gt;&lt;res size=&quot;3041126&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3"/><CurrentMediaDuration val="0:00:00.000"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.03 11:55:21 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3"/><NumberOfTracks val="1"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;Röschenhof&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;A.O.K.&lt;/upnp:artist&gt;&lt;upnp:album&gt;Dreilochbegehbar und Herrenrundentauglich&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2006-01-01&lt;/dc:date&gt;&lt;res size=&quot;3041126&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><PlaybackStorageMedium val="NETWORK"/><CurrentMediaCategory val="TRACK_AWARE"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="STOPPED"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="1"/><CurrentTrackDuration val="0:00:00.000"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;Röschenhof&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;A.O.K.&lt;/upnp:artist&gt;&lt;upnp:album&gt;Dreilochbegehbar und Herrenrundentauglich&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2006-01-01&lt;/dc:date&gt;&lt;res size=&quot;3041126&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3"/><CurrentMediaDuration val="0:00:00.000"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.03 11:55:21 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3"/><NumberOfTracks val="1"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;Röschenhof&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;A.O.K.&lt;/upnp:artist&gt;&lt;upnp:album&gt;Dreilochbegehbar und Herrenrundentauglich&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2006-01-01&lt;/dc:date&gt;&lt;res size=&quot;3041126&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><PlaybackStorageMedium val="NETWORK"/><CurrentMediaCategory val="TRACK_AWARE"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="STOPPED"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="1"/><CurrentTrackDuration val="0:00:00.000"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;&lt;item id=&quot;0&quot; restricted=&quot;1&quot;&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;dc:title&gt;Röschenhof&lt;/dc:title&gt;&lt;upnp:artist role=&quot;albumArtist&quot;&gt;A.O.K.&lt;/upnp:artist&gt;&lt;upnp:album&gt;Dreilochbegehbar und Herrenrundentauglich&lt;/upnp:album&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.1:49200/EXTRACTALBUMART/mp3/DLNA-14-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.jpg&lt;/upnp:albumArtURI&gt;&lt;upnp:genre&gt;Metal&lt;/upnp:genre&gt;&lt;dc:date&gt;2006-01-01&lt;/dc:date&gt;&lt;res size=&quot;3041126&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot;&gt;http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.1:49200/AUDIO/DLNA-1-0/music/MyFavorites/Special/A.O.K.%20-%20R%c3%b6schenhof.mp3"/><CurrentMediaDuration val="0:00:00.000"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>

2021.04.03 11:55:31 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300

2021.04.03 11:55:35 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xa436268) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/AVT/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;TransportState val=&quot;PLAYING&quot;/&gt;&lt;CurrentTransportActions val=&quot;Play,Pause,Stop&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 11:55:35 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
2021.04.03 11:55:35 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
2021.04.03 11:55:35 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
2021.04.03 11:55:35 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
2021.04.03 11:55:39 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.04.03 11:55:39 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.04.03 11:55:39 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.04.03 11:55:57 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xa436268) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/AVT/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;TransportState val=&quot;STOPPED&quot;/&gt;&lt;CurrentTransportActions val=&quot;Play,Stop&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 11:55:57 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="STOPPED"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.03 11:55:57 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="STOPPED"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.03 11:55:57 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="STOPPED"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.03 11:55:57 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="STOPPED"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>


EDIT:
Log gekürzt, da es das Code-Ende-Tag und meinen restlichen Kommentar gekillt hat ;)

Viele Grüße
Dieter
Raspbian (Buster) auf Raspberry Pi 4 /  CUL + RFXTRX + TCM / FS20, FHT 80B, S300TH, Intertechno, DMX, Milight, EnOcean, Homematic, AMAD, Home Connect, MiSmartHome, Yeelight, ...

KölnSolar

Hi Dieter,
Zitat2021.04.03 11:55:21 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.61_2870
2021.04.03 11:55:21 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 790.

2021.04.03 11:55:21 3: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.61_2870 failed: , try to subscribe
2021.04.03 11:55:21 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.61_2870-zs-AVTransport
2021.04.03 11:55:21 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.04.03 11:55:21 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 11:55:21 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 11:55:21 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport timeout: 300
Auch wenn das renewal fehlgeschlagen ist, hat das Modul den Zustand geheilt. Eigentlich hättest Du Befehle per FB permanent empfangen müssen.  :-\

Nur der Vollständigkeit halber die initiale Subscription zum Zeitvergleich. Das Modul hat das renewal also definitiv im Zeitraum 300s durchgeführt.
Zitat2021.04.03 11:51:19 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.04.03 11:51:19 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 11:51:19 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 11:51:19 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport timeout: 300

Zitat2021.04.03 11:53:55 4: UPNPController: RenderingControl, SetVolume(0,Master,18) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
Lass die Versuche per FHEM zu steuern mal weg. Vielleicht zerschießen die die subscription.  :-\

Grüße Markus
RPi3/2 buster/stretch-SamsungAV_E/N-RFXTRX-IT-RSL-NC5462-Oregon-CUL433-GT-TMBBQ-01e-CUL868-FS20-EMGZ-1W(GPIO)-DS18B20-CO2-USBRS232-USBRS422-Betty_Boop-EchoDot-OBIS(Easymeter-Q3/EMH-KW8)-PCA301(S'duino)-Deebot(mqtt2)-zigbee2mqtt

RockFan

Hallo Markus,

leider hat mir das Log im letzten Post das Code-Ende-Tag und meinen restlichen Kommentar zerschossen  :'(

Den Versuch mit FHEM zu steuern habe ich in nahezu allen Tests, seit der Fokus auf die Rückmeldung vom TV liegt, immer erst gemacht, nachdem ich mit der FB Lautstärke und Mute probiert habe.
So auch im letzten Test. Lautstärke und Mute kommen einfach nicht in FHEM an.

Trotzdem hier nochmal ein neuer Versuch. FHEM habe ich nun ausschließlich beobachtet:
(ich hoffe das Log kommt diesmal durch)


2021.04.03 13:42:17 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceAdded
2021.04.03 13:42:17 5: UPNPController: UPNP_Controller: alive-notify message device uuid:13cae598-3cca-165a-8000-0009dfbd33fb received
2021.04.03 13:42:17 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 547.

2021.04.03 13:42:17 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb found. Check for processing
2021.04.03 13:42:17 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb will be controlled with 192.168.178.61_2870
2021.04.03 13:42:17 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: RenderingControl
2021.04.03 13:42:17 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.04.03 13:42:17 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 13:42:17 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 13:42:18 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl timeout: 300
2021.04.03 13:42:18 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: ConnectionManager
2021.04.03 13:42:18 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: AVTransport
2021.04.03 13:42:18 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.04.03 13:42:18 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 13:42:18 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 13:42:18 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport timeout: 300
2021.04.03 13:42:18 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 13:42:18 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 13:42:18 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 13:42:18 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xa7b4478) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/RCS/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;Mute channel=&quot;Master&quot; val=&quot;0&quot;/&gt;&lt;Volume channel=&quot;Master&quot; val=&quot;0&quot;/&gt;&lt;VolumeDB channel=&quot;Master&quot; val=&quot;-32768&quot;/&gt;&lt;PresetNameList val=&quot;FactoryDefaults&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 13:42:18 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 13:42:18 5: UPNP_Controller: dispatch RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 13:42:18 5: DLNAController: message from UPNP_Controller, message: RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 13:42:18 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 13:42:18 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xa7a04f8) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/AVT/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;AVTransportURI val=&quot;&quot;/&gt;&lt;NumberOfTracks val=&quot;0&quot;/&gt;&lt;AVTransportURIMetaData val=&quot;&quot;/&gt;&lt;PlaybackStorageMedium val=&quot;NONE&quot;/&gt;&lt;CurrentMediaCategory val=&quot;NO_MEDIA&quot;/&gt;&lt;PossiblePlaybackStorageMedia val=&quot;NONE,NETWORK&quot;/&gt;&lt;RecordStorageMedium val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;PossibleRecordStorageMedia val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;RecordMediumWriteStatus val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;NextAVTransportURI val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;NextAVTransportURIMetaData val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;CurrentPlayMode val=&quot;NORMAL&quot;/&gt;&lt;CurrentRecordQualityMode val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;PossibleRecordQualityModes val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;TransportState val=&quot;NO_MEDIA_PRESENT&quot;/&gt;&lt;TransportStatus val=&quot;OK&quot;/&gt;&lt;TransportPlaySpeed val=&quot;1&quot;/&gt;&lt;CurrentTrack val=&quot;0&quot;/&gt;&lt;CurrentTrackDuration val=&quot;00:00:00&quot;/&gt;&lt;CurrentTrackMetaData val=&quot;&quot;/&gt;&lt;CurrentTrackURI val=&quot;&quot;/&gt;&lt;CurrentMediaDuration val=&quot;00:00:00&quot;/&gt;&lt;CurrentTransportActions val=&quot;&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 13:42:18 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 13:42:18 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 13:42:18 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 13:42:18 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>

2021.04.03 13:42:23 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300

2021.04.03 13:43:19 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xa7a04f8) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/AVT/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;AVTransportURI val=&quot;http://192.168.178.27:37345/dlna/media/1479171039&quot;/&gt;&lt;NumberOfTracks val=&quot;1&quot;/&gt;&lt;AVTransportURIMetaData val=&quot;&amp;lt;DIDL-Lite xmlns=&amp;quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&amp;quot; xmlns:upnp=&amp;quot;urn:schemas-upnp-org:metadata-1-0/upnp/&amp;quot; xmlns:dc=&amp;quot;http://purl.org/dc/elements/1.1/&amp;quot; xmlns:sec=&amp;quot;http://www.sec.co.kr/&amp;quot;&amp;gt;&amp;lt;item id=&amp;quot;1479171039&amp;quot; parentID=&amp;quot;audio&amp;quot; restricted=&amp;quot;0&amp;quot;&amp;gt;&amp;lt;dc:title&amp;gt;Voices Carry&amp;lt;/dc:title&amp;gt;&amp;lt;dc:creator&amp;gt;&amp;apos;Til Tuesday&amp;lt;/dc:creator&amp;gt;&amp;lt;upnp:class&amp;gt;object.item.audioItem.musicTrack&amp;lt;/upnp:class&amp;gt;&amp;lt;upnp:b&amp;gt;Voices Carry&amp;lt;/upnp:b&amp;gt;&amp;lt;upnp:d role=&amp;quot;Performer&amp;quot;&amp;gt;&amp;apos;Til Tuesday&amp;lt;/upnp:d&amp;gt;&amp;lt;upnp:albumArtURI&amp;gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&amp;lt;/upnp:albumArtURI&amp;gt;&amp;lt;upnp:icon&amp;gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&amp;lt;/upnp:icon&amp;gt;&amp;lt;res protocolInfo=&amp;quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; size=&amp;quot;7350272&amp;quot; duration=&amp;quot;0:4:20&amp;quot;&amp;gt;http://192.168.178.27:37345/dlna/media/1479171039&amp;lt;/res&amp;gt;&amp;lt;res protocolInfo=&amp;quot;http-get:*:image/jpeg:DLNA.ORG_PN=JPEG_TN;DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=00d00000000000000000000000000000&amp;quot;&amp;gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&amp;lt;/res&amp;gt;&amp;lt;/item&amp;gt;&amp;lt;/DIDL-Lite&amp;gt;&quot;/&gt;&lt;PlaybackStorageMedium val=&quot;NETWORK&quot;/&gt;&lt;CurrentMediaCategory val=&quot;TRACK_AWARE&quot;/&gt;&lt;TransportState val=&quot;STOPPED&quot;/&gt;&lt;CurrentTrack val=&quot;1&quot;/&gt;&lt;CurrentTrackDuration val=&quot;0:00:00.000&quot;/&gt;&lt;CurrentTrackMetaData val=&quot;&amp;lt;DIDL-Lite xmlns=&amp;quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&amp;quot; xmlns:upnp=&amp;quot;urn:schemas-upnp-org:metadata-1-0/upnp/&amp;quot; xmlns:dc=&amp;quot;http://purl.org/dc/elements/1.1/&amp;quot; xmlns:sec=&amp;quot;http://www.sec.co.kr/&amp;quot;&amp;gt;&amp;lt;item id=&amp;quot;1479171039&amp;quot; parentID=&amp;quot;audio&amp;quot; restricted=&amp;quot;0&amp;quot;&amp;gt;&amp;lt;dc:title&amp;gt;Voices Carry&amp;lt;/dc:title&amp;gt;&amp;lt;dc:creator&amp;gt;&amp;apos;Til Tuesday&amp;lt;/dc:creator&amp;gt;&amp;lt;upnp:class&amp;gt;object.item.audioItem.musicTrack&amp;lt;/upnp:class&amp;gt;&amp;lt;upnp:b&amp;gt;Voices Carry&amp;lt;/upnp:b&amp;gt;&amp;lt;upnp:d role=&amp;quot;Performer&amp;quot;&amp;gt;&amp;apos;Til Tuesday&amp;lt;/upnp:d&amp;gt;&amp;lt;upnp:albumArtURI&amp;gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&amp;lt;/upnp:albumArtURI&amp;gt;&amp;lt;upnp:icon&amp;gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&amp;lt;/upnp:icon&amp;gt;&amp;lt;res protocolInfo=&amp;quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; size=&amp;quot;7350272&amp;quot; duration=&amp;quot;0:4:20&amp;quot;&amp;gt;http://192.168.178.27:37345/dlna/media/1479171039&amp;lt;/res&amp;gt;&amp;lt;res protocolInfo=&amp;quot;http-get:*:image/jpeg:DLNA.ORG_PN=JPEG_TN;DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=00d00000000000000000000000000000&amp;quot;&amp;gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&amp;lt;/res&amp;gt;&amp;lt;/item&amp;gt;&amp;lt;/DIDL-Lite&amp;gt;&quot;/&gt;&lt;CurrentTrackURI val=&quot;http://192.168.178.27:37345/dlna/media/1479171039&quot;/&gt;&lt;CurrentTransportActions val=&quot;Play,Stop&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 13:43:19 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val="http://192.168.178.27:37345/dlna/media/1479171039"/><NumberOfTracks val="1"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:sec=&quot;http://www.sec.co.kr/&quot;&gt;&lt;item id=&quot;1479171039&quot; parentID=&quot;audio&quot; restricted=&quot;0&quot;&gt;&lt;dc:title&gt;Voices Carry&lt;/dc:title&gt;&lt;dc:creator&gt;&apos;Til Tuesday&lt;/dc:creator&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;upnp:b&gt;Voices Carry&lt;/upnp:b&gt;&lt;upnp:d role=&quot;Performer&quot;&gt;&apos;Til Tuesday&lt;/upnp:d&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:albumArtURI&gt;&lt;upnp:icon&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:icon&gt;&lt;res protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; size=&quot;7350272&quot; duration=&quot;0:4:20&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039&lt;/res&gt;&lt;res protocolInfo=&quot;http-get:*:image/jpeg:DLNA.ORG_PN=JPEG_TN;DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=00d00000000000000000000000000000&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><PlaybackStorageMedium val="NETWORK"/><CurrentMediaCategory val="TRACK_AWARE"/><TransportState val="STOPPED"/><CurrentTrack val="1"/><CurrentTrackDuration val="0:00:00.000"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:sec=&quot;http://www.sec.co.kr/&quot;&gt;&lt;item id=&quot;1479171039&quot; parentID=&quot;audio&quot; restricted=&quot;0&quot;&gt;&lt;dc:title&gt;Voices Carry&lt;/dc:title&gt;&lt;dc:creator&gt;&apos;Til Tuesday&lt;/dc:creator&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;upnp:b&gt;Voices Carry&lt;/upnp:b&gt;&lt;upnp:d role=&quot;Performer&quot;&gt;&apos;Til Tuesday&lt;/upnp:d&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:albumArtURI&gt;&lt;upnp:icon&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:icon&gt;&lt;res protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; size=&quot;7350272&quot; duration=&quot;0:4:20&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039&lt;/res&gt;&lt;res protocolInfo=&quot;http-get:*:image/jpeg:DLNA.ORG_PN=JPEG_TN;DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=00d00000000000000000000000000000&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.27:37345/dlna/media/1479171039"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.03 13:43:19 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val="http://192.168.178.27:37345/dlna/media/1479171039"/><NumberOfTracks val="1"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:sec=&quot;http://www.sec.co.kr/&quot;&gt;&lt;item id=&quot;1479171039&quot; parentID=&quot;audio&quot; restricted=&quot;0&quot;&gt;&lt;dc:title&gt;Voices Carry&lt;/dc:title&gt;&lt;dc:creator&gt;&apos;Til Tuesday&lt;/dc:creator&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;upnp:b&gt;Voices Carry&lt;/upnp:b&gt;&lt;upnp:d role=&quot;Performer&quot;&gt;&apos;Til Tuesday&lt;/upnp:d&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:albumArtURI&gt;&lt;upnp:icon&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:icon&gt;&lt;res protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; size=&quot;7350272&quot; duration=&quot;0:4:20&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039&lt;/res&gt;&lt;res protocolInfo=&quot;http-get:*:image/jpeg:DLNA.ORG_PN=JPEG_TN;DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=00d00000000000000000000000000000&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><PlaybackStorageMedium val="NETWORK"/><CurrentMediaCategory val="TRACK_AWARE"/><TransportState val="STOPPED"/><CurrentTrack val="1"/><CurrentTrackDuration val="0:00:00.000"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:sec=&quot;http://www.sec.co.kr/&quot;&gt;&lt;item id=&quot;1479171039&quot; parentID=&quot;audio&quot; restricted=&quot;0&quot;&gt;&lt;dc:title&gt;Voices Carry&lt;/dc:title&gt;&lt;dc:creator&gt;&apos;Til Tuesday&lt;/dc:creator&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;upnp:b&gt;Voices Carry&lt;/upnp:b&gt;&lt;upnp:d role=&quot;Performer&quot;&gt;&apos;Til Tuesday&lt;/upnp:d&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:albumArtURI&gt;&lt;upnp:icon&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:icon&gt;&lt;res protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; size=&quot;7350272&quot; duration=&quot;0:4:20&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039&lt;/res&gt;&lt;res protocolInfo=&quot;http-get:*:image/jpeg:DLNA.ORG_PN=JPEG_TN;DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=00d00000000000000000000000000000&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.27:37345/dlna/media/1479171039"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.03 13:43:19 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val="http://192.168.178.27:37345/dlna/media/1479171039"/><NumberOfTracks val="1"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:sec=&quot;http://www.sec.co.kr/&quot;&gt;&lt;item id=&quot;1479171039&quot; parentID=&quot;audio&quot; restricted=&quot;0&quot;&gt;&lt;dc:title&gt;Voices Carry&lt;/dc:title&gt;&lt;dc:creator&gt;&apos;Til Tuesday&lt;/dc:creator&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;upnp:b&gt;Voices Carry&lt;/upnp:b&gt;&lt;upnp:d role=&quot;Performer&quot;&gt;&apos;Til Tuesday&lt;/upnp:d&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:albumArtURI&gt;&lt;upnp:icon&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:icon&gt;&lt;res protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; size=&quot;7350272&quot; duration=&quot;0:4:20&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039&lt;/res&gt;&lt;res protocolInfo=&quot;http-get:*:image/jpeg:DLNA.ORG_PN=JPEG_TN;DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=00d00000000000000000000000000000&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><PlaybackStorageMedium val="NETWORK"/><CurrentMediaCategory val="TRACK_AWARE"/><TransportState val="STOPPED"/><CurrentTrack val="1"/><CurrentTrackDuration val="0:00:00.000"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:sec=&quot;http://www.sec.co.kr/&quot;&gt;&lt;item id=&quot;1479171039&quot; parentID=&quot;audio&quot; restricted=&quot;0&quot;&gt;&lt;dc:title&gt;Voices Carry&lt;/dc:title&gt;&lt;dc:creator&gt;&apos;Til Tuesday&lt;/dc:creator&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;upnp:b&gt;Voices Carry&lt;/upnp:b&gt;&lt;upnp:d role=&quot;Performer&quot;&gt;&apos;Til Tuesday&lt;/upnp:d&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:albumArtURI&gt;&lt;upnp:icon&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:icon&gt;&lt;res protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; size=&quot;7350272&quot; duration=&quot;0:4:20&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039&lt;/res&gt;&lt;res protocolInfo=&quot;http-get:*:image/jpeg:DLNA.ORG_PN=JPEG_TN;DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=00d00000000000000000000000000000&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.27:37345/dlna/media/1479171039"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.03 13:43:19 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val="http://192.168.178.27:37345/dlna/media/1479171039"/><NumberOfTracks val="1"/><AVTransportURIMetaData val="&lt;DIDL-Lite xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:sec=&quot;http://www.sec.co.kr/&quot;&gt;&lt;item id=&quot;1479171039&quot; parentID=&quot;audio&quot; restricted=&quot;0&quot;&gt;&lt;dc:title&gt;Voices Carry&lt;/dc:title&gt;&lt;dc:creator&gt;&apos;Til Tuesday&lt;/dc:creator&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;upnp:b&gt;Voices Carry&lt;/upnp:b&gt;&lt;upnp:d role=&quot;Performer&quot;&gt;&apos;Til Tuesday&lt;/upnp:d&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:albumArtURI&gt;&lt;upnp:icon&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:icon&gt;&lt;res protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; size=&quot;7350272&quot; duration=&quot;0:4:20&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039&lt;/res&gt;&lt;res protocolInfo=&quot;http-get:*:image/jpeg:DLNA.ORG_PN=JPEG_TN;DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=00d00000000000000000000000000000&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><PlaybackStorageMedium val="NETWORK"/><CurrentMediaCategory val="TRACK_AWARE"/><TransportState val="STOPPED"/><CurrentTrack val="1"/><CurrentTrackDuration val="0:00:00.000"/><CurrentTrackMetaData val="&lt;DIDL-Lite xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:sec=&quot;http://www.sec.co.kr/&quot;&gt;&lt;item id=&quot;1479171039&quot; parentID=&quot;audio&quot; restricted=&quot;0&quot;&gt;&lt;dc:title&gt;Voices Carry&lt;/dc:title&gt;&lt;dc:creator&gt;&apos;Til Tuesday&lt;/dc:creator&gt;&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;&lt;upnp:b&gt;Voices Carry&lt;/upnp:b&gt;&lt;upnp:d role=&quot;Performer&quot;&gt;&apos;Til Tuesday&lt;/upnp:d&gt;&lt;upnp:albumArtURI&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:albumArtURI&gt;&lt;upnp:icon&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/upnp:icon&gt;&lt;res protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; size=&quot;7350272&quot; duration=&quot;0:4:20&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039&lt;/res&gt;&lt;res protocolInfo=&quot;http-get:*:image/jpeg:DLNA.ORG_PN=JPEG_TN;DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=00d00000000000000000000000000000&quot;&gt;http://192.168.178.27:37345/dlna/media/1479171039/thumbnail&lt;/res&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.27:37345/dlna/media/1479171039"/><CurrentTransportActions val="Play,Stop"/></InstanceID></Event>
2021.04.03 13:43:19 3: UPNPController: handleOnce failed, Not a HASH reference at ./FHEM/98_DLNAController.pm line 742.

2021.04.03 13:43:20 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xa7a04f8) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/AVT/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;TransportState val=&quot;PLAYING&quot;/&gt;&lt;CurrentTrackDuration val=&quot;72:13:20.000&quot;/&gt;&lt;CurrentTransportActions val=&quot;Play,Pause,Stop&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 13:43:20 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentTrackDuration val="72:13:20.000"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
2021.04.03 13:43:20 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentTrackDuration val="72:13:20.000"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
2021.04.03 13:43:20 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentTrackDuration val="72:13:20.000"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
2021.04.03 13:43:20 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentTrackDuration val="72:13:20.000"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>


Das Streaming ist bisher das Einzige, das während das TV-Gerät in Betrieb ist, sichtbar wird. Änderungen an Lautstärke und Mute kommen nicht an.

Viele Grüße
Dieter
Raspbian (Buster) auf Raspberry Pi 4 /  CUL + RFXTRX + TCM / FS20, FHT 80B, S300TH, Intertechno, DMX, Milight, EnOcean, Homematic, AMAD, Home Connect, MiSmartHome, Yeelight, ...

KölnSolar

Hi Dieter,
ZitatLautstärke und Mute kommen einfach nicht in FHEM an.
wohl keine Chance wg.
Zitatich werd verrückt. Im xml steht Code: [Auswählen]

<stateVariable sendEvents="yes">
</stateVariable>

Müsste aber so
Code: [Auswählen]

<stateVariable sendEvents="yes">
<name>LastChange</name>
<dataType>string</dataType>
</stateVariable>

aussehen.
AVTransport klappt also mit den events, auch wenn unklar ist, warum das renewal fehlschlägt. Dazu könntest Du testweise auch ruhig mal den Wert von 300 auf 100 ändern.

Hattest Du bereits das streaming aus FHEM heraus getestet ? Auch ein Fehler 501 ?

Grüße
Markus



RPi3/2 buster/stretch-SamsungAV_E/N-RFXTRX-IT-RSL-NC5462-Oregon-CUL433-GT-TMBBQ-01e-CUL868-FS20-EMGZ-1W(GPIO)-DS18B20-CO2-USBRS232-USBRS422-Betty_Boop-EchoDot-OBIS(Easymeter-Q3/EMH-KW8)-PCA301(S'duino)-Deebot(mqtt2)-zigbee2mqtt

RockFan

Hi Markus,

keine sichtbare Veränderung durch das Heruntersetzen des Timeouts. Zum Streamen aus FHEM habe ich es mal mit dem bereits vorgegebenen Google-Translate-Stream versucht; leider ohne Erfolg. Dann habe ich noch vergeblich Speak "Hallo" ausprobiert. Und hier sind wieder die Logs :)

2021.04.03 17:44:39 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceAdded
2021.04.03 17:44:39 5: UPNPController: UPNP_Controller: alive-notify message device uuid:13cae598-3cca-165a-8000-0009dfbd33fb received
2021.04.03 17:44:39 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 547.

2021.04.03 17:44:39 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb found. Check for processing
2021.04.03 17:44:39 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb will be controlled with 192.168.178.61_2870
2021.04.03 17:44:39 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: RenderingControl
2021.04.03 17:44:39 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.04.03 17:44:39 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 17:44:39 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 17:44:39 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl timeout: 300
2021.04.03 17:44:39 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: ConnectionManager
2021.04.03 17:44:39 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: AVTransport
2021.04.03 17:44:39 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.04.03 17:44:39 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:44:39 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:44:39 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport timeout: 300
2021.04.03 17:44:39 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 17:44:39 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 17:44:39 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 17:44:39 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xa729c70) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/RCS/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;Mute channel=&quot;Master&quot; val=&quot;0&quot;/&gt;&lt;Volume channel=&quot;Master&quot; val=&quot;0&quot;/&gt;&lt;VolumeDB channel=&quot;Master&quot; val=&quot;-32768&quot;/&gt;&lt;PresetNameList val=&quot;FactoryDefaults&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 17:44:39 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 17:44:39 5: UPNP_Controller: dispatch RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 17:44:39 5: DLNAController: message from UPNP_Controller, message: RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>
2021.04.03 17:44:39 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="0"/><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/><PresetNameList val="FactoryDefaults"/></InstanceID></Event>

2021.04.03 17:44:41 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xb685d38) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/AVT/&quot;&gt;&lt;InstanceID val=&quot;0&quot;&gt;&lt;AVTransportURI val=&quot;&quot;/&gt;&lt;NumberOfTracks val=&quot;0&quot;/&gt;&lt;AVTransportURIMetaData val=&quot;&quot;/&gt;&lt;PlaybackStorageMedium val=&quot;NONE&quot;/&gt;&lt;CurrentMediaCategory val=&quot;NO_MEDIA&quot;/&gt;&lt;PossiblePlaybackStorageMedia val=&quot;NONE,NETWORK&quot;/&gt;&lt;RecordStorageMedium val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;PossibleRecordStorageMedia val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;RecordMediumWriteStatus val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;NextAVTransportURI val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;NextAVTransportURIMetaData val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;CurrentPlayMode val=&quot;NORMAL&quot;/&gt;&lt;CurrentRecordQualityMode val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;PossibleRecordQualityModes val=&quot;NOT_IMPLEMENTED&quot;/&gt;&lt;TransportState val=&quot;NO_MEDIA_PRESENT&quot;/&gt;&lt;TransportStatus val=&quot;OK&quot;/&gt;&lt;TransportPlaySpeed val=&quot;1&quot;/&gt;&lt;CurrentTrack val=&quot;0&quot;/&gt;&lt;CurrentTrackDuration val=&quot;00:00:00&quot;/&gt;&lt;CurrentTrackMetaData val=&quot;&quot;/&gt;&lt;CurrentTrackURI val=&quot;&quot;/&gt;&lt;CurrentMediaDuration val=&quot;00:00:00&quot;/&gt;&lt;CurrentTransportActions val=&quot;&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.04.03 17:44:41 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 17:44:41 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 17:44:41 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 17:44:41 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/"><InstanceID val="0"><AVTransportURI val=""/><NumberOfTracks val="0"/><AVTransportURIMetaData val=""/><PlaybackStorageMedium val="NONE"/><CurrentMediaCategory val="NO_MEDIA"/><PossiblePlaybackStorageMedia val="NONE,NETWORK"/><RecordStorageMedium val="NOT_IMPLEMENTED"/><PossibleRecordStorageMedia val="NOT_IMPLEMENTED"/><RecordMediumWriteStatus val="NOT_IMPLEMENTED"/><NextAVTransportURI val="NOT_IMPLEMENTED"/><NextAVTransportURIMetaData val="NOT_IMPLEMENTED"/><CurrentPlayMode val="NORMAL"/><CurrentRecordQualityMode val="NOT_IMPLEMENTED"/><PossibleRecordQualityModes val="NOT_IMPLEMENTED"/><TransportState val="NO_MEDIA_PRESENT"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="0"/><CurrentTrackDuration val="00:00:00"/><CurrentTrackMetaData val=""/><CurrentTrackURI val=""/><CurrentMediaDuration val="00:00:00"/><CurrentTransportActions val=""/></InstanceID></Event>
2021.04.03 17:44:49 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300

2021.04.03 17:45:49 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300

2021.04.03 17:46:09 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, SetAVTransportURI, 0 http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>
2021.04.03 17:46:09 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:10 4: UPNPController: AVTransport, SetAVTransportURI(0,http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo,<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 17:46:10 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, Play, 0 1
2021.04.03 17:46:10 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:10 4: UPNPController: AVTransport, Play(0,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 17:46:15 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, SetAVTransportURI, 0 http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>
2021.04.03 17:46:15 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:15 4: UPNPController: AVTransport, SetAVTransportURI(0,http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo,<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 17:46:15 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, Play, 0 1
2021.04.03 17:46:15 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:15 4: UPNPController: AVTransport, Play(0,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorCode => 501, errorDescription => 'Action Failed'}}"

2021.04.03 17:46:22 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, SetAVTransportURI, 0 http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>
2021.04.03 17:46:22 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:22 4: UPNPController: AVTransport, SetAVTransportURI(0,http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo,<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"

2021.04.03 17:46:24 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, Play, 0 1
2021.04.03 17:46:24 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:24 4: UPNPController: AVTransport, Play(0,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 17:46:26 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, SetAVTransportURI, 0 http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>
2021.04.03 17:46:26 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:26 4: UPNPController: AVTransport, SetAVTransportURI(0,http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo,<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorCode => 501, errorDescription => 'Action Failed'}}"
2021.04.03 17:46:26 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, Play, 0 1
2021.04.03 17:46:26 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:26 4: UPNPController: AVTransport, Play(0,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 17:46:27 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, SetAVTransportURI, 0 http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>
2021.04.03 17:46:27 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:27 4: UPNPController: AVTransport, SetAVTransportURI(0,http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo,<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 17:46:27 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, Play, 0 1
2021.04.03 17:46:27 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:27 4: UPNPController: AVTransport, Play(0,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorCode => 501, errorDescription => 'Action Failed'}}"
2021.04.03 17:46:27 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, SetAVTransportURI, 0 http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>
2021.04.03 17:46:27 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:27 4: UPNPController: AVTransport, SetAVTransportURI(0,http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo,<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/"><item id="-1" parentID="parent" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</dc:title><upnp:album>http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000" size="3264">http://translate.google.com/translate_tts?tl=en&amp;client=tw-ob&amp;q=Hallo</res></item></DIDL-Lite>) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 17:46:27 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, Play, 0 1
2021.04.03 17:46:27 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:27 4: UPNPController: AVTransport, Play(0,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorCode => 501, errorDescription => 'Action Failed'}}"
2021.04.03 17:46:28 3: Nmap (HomeDevices) - network scan done
2021.04.03 17:46:28 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.04.03 17:46:28 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.04.03 17:46:28 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.04.03 17:46:49 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 300
2021.04.03 17:46:49 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, SetAVTransportURI, 0 http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo
2021.04.03 17:46:49 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:49 4: UPNPController: AVTransport, SetAVTransportURI(0,http://translate.google.com/translate_tts?tl=en&client=tw-ob&q=Hallo,) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 17:46:50 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, Play, 0 1
2021.04.03 17:46:50 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 17:46:50 4: UPNPController: AVTransport, Play(0,1) didn't succeed.Error! UPnP-Fault-Fields: Code: "s:Client", String: "UPnPError", Actor: "-", Detail: "{UPnPError => {errorDescription => 'Action Failed', errorCode => 501}}"
2021.04.03 17:46:55 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.04.03 17:46:55 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.04.03 17:46:55 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.



Mich wundert, dass ich im Log überall timeout 300 lese, obwohl ich ihn aus 100 geändert habe und habe gerade nochmal einen Reload gemacht. diesmal sehe ich zumindest ein paar 100er Timeouts:

2021.04.03 18:03:58 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 100


2021.04.03 18:05:01 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 100


2021.04.03 18:06:04 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 100


2021.04.03 18:07:08 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 100


Aber dann ist er plötzlich wieder auf 300:

2021.04.03 18:07:52 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceAdded
2021.04.03 18:07:52 5: UPNPController: UPNP_Controller: alive-notify message device uuid:13cae598-3cca-165a-8000-0009dfbd33fb received
2021.04.03 18:07:52 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 547.

2021.04.03 18:07:52 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb found. Check for processing
2021.04.03 18:07:52 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb will be controlled with 192.168.178.61_2870
2021.04.03 18:07:52 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: RenderingControl
2021.04.03 18:07:52 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.04.03 18:07:52 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 18:07:52 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.04.03 18:07:52 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl timeout: 300
2021.04.03 18:07:52 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: ConnectionManager
2021.04.03 18:07:52 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: AVTransport
2021.04.03 18:07:52 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.04.03 18:07:52 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 18:07:52 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.04.03 18:07:52 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport timeout: 300
2021.04.03 18:07:52 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 18:07:52 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.04.03 18:07:52 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT


Seltsam ???

Viele Grüße
Dieter
Raspbian (Buster) auf Raspberry Pi 4 /  CUL + RFXTRX + TCM / FS20, FHT 80B, S300TH, Intertechno, DMX, Milight, EnOcean, Homematic, AMAD, Home Connect, MiSmartHome, Yeelight, ...

KölnSolar

Hi Dieter,
ZitatSeltsam ???
Gar nicht. Die 300 liefert der TV zurück. Die 100 gibt das Modul als Wunsch an den TV.  ;)

Ich fass dann mal zusammen:
- online/offline funktioniert
- renewal der subscription läuft auf Fehler 412
  wird aber durch das Modul "geheilt"
- keine events v. RenderingControl(volume, mute...) wg. fehlerhafter xml-description
- events f. AVTransport(streaming)
- ausgelöste actions laufen auf Fehler 501

Hattest Du den Mediaplayer wg. der actions probiert ?

Kennst Du Wireshark ? Das könnten wir zur Analyse einsetzen, wenn die actions mit dem Mediaplayer funktionieren. Du könntest jetzt die actions auch mal mit den beiden Attributen envNamespace u. envPrefix beim UPNPController testen. Mindestens das modify nach Attribut setzen nötig !!!

Eki's Modul ging bei Dir nicht. Richtig ?  :-\

Grüße
Markus
RPi3/2 buster/stretch-SamsungAV_E/N-RFXTRX-IT-RSL-NC5462-Oregon-CUL433-GT-TMBBQ-01e-CUL868-FS20-EMGZ-1W(GPIO)-DS18B20-CO2-USBRS232-USBRS422-Betty_Boop-EchoDot-OBIS(Easymeter-Q3/EMH-KW8)-PCA301(S'duino)-Deebot(mqtt2)-zigbee2mqtt