98_UPNPController/98_DLNAController und VestelTVs

[RockFan]

Hallo Markus,

wie in Deinem Diskussions-Thread zu den neuen Modulen gewünscht (https://forum.fhem.de/index.php/topic,118837.msg1139244.html#msg1139244), hier nun ein neuer Thread mit Testergebnissen zu VestelTVs bzw. konkret meinem Medion TV Gerät.

Vorab erstmal:
Das sichtbare Verhalten hat sich mit den neuen Versionen der Module für mich nicht geändert. UPNPController und UPNPSocket-UPNP_Controller-44169 habe ich auf verbose=5 gesetzt und dann meine Tests heute gegen 11:30 Uhr vornehmlich mit der Fernbedienung begonnen. Von dem Helper Device sehe ich keine Logeinträge. Ist das richtig?
Die Aktionen auf der FB bzgl. Volume und Mute finden sich meiner Ansicht nach überhaupt nicht im Log. Aber das kannst Du natürlich besser beurteilen.

Das DLNAController Device hatte zu Testbeginn den Status offline.

Code Auswählen Erweitern


2021.03.14 11:29:47 4: UPNPController: discovery message of MEDION-Radio with UDN: uuid:3DCC7100-F76C-11DD-87AF-305890619AC8 action: deviceAdded
2021.03.14 11:29:47 5: UPNPController: UPNP_Controller: alive-notify message device uuid:3DCC7100-F76C-11DD-87AF-305890619AC8 received
2021.03.14 11:29:47 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 544.

2021.03.14 11:29:47 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 544.

2021.03.14 11:29:47 5: UPNPController: UPNP_Controller: device uuid:3DCC7100-F76C-11DD-87AF-305890619AC8 found. Check for processing
2021.03.14 11:29:47 5: UPNPController: UPNP_Controller: device uuid:3DCC7100-F76C-11DD-87AF-305890619AC8 will be controlled with 192.168.178.58_8080
2021.03.14 11:29:47 5: UPNPController: UPNP_Controller: device uuid:3DCC7100-F76C-11DD-87AF-305890619AC8 has service with serviceId: AVTransport
2021.03.14 11:29:47 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-AVTransport, uniquedevice 192.168.178.58_8080, service AVTransport
2021.03.14 11:29:47 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:29:47 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:29:47 5: UPNPController: UPNP_Controller: device uuid:3DCC7100-F76C-11DD-87AF-305890619AC8 has service with serviceId: ConnectionManager
2021.03.14 11:29:47 5: UPNPController: UPNP_Controller: device uuid:3DCC7100-F76C-11DD-87AF-305890619AC8 has service with serviceId: RenderingControl
2021.03.14 11:29:47 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-RenderingControl, uniquedevice 192.168.178.58_8080, service RenderingControl
2021.03.14 11:29:47 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:29:47 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:29:48 5: UPNP_Controller: dispatch RenderingControl|192.168.178.58_8080|online|urn:schemas-upnp-org:metadata-1-0/RCS
2021.03.14 11:29:48 5: DLNAController: message from UPNP_Controller, message: RenderingControl|192.168.178.58_8080|online|urn:schemas-upnp-org:metadata-1-0/RCS
2021.03.14 11:29:48 4: DLNAController: message parameters: RenderingControl, 192.168.178.58_8080, online, urn:schemas-upnp-org:metadata-1-0/RCS
2021.03.14 11:29:57 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.14 11:30:01 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

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

2021.03.14 11:30:01 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.14 11:30:19 1: [Freezemon] myFreezemon: possible freeze starting at 11:30:17, delay is 2.414 possibly caused by: tmr-at_Exec(on_timer_action) tmr-SYSMON_Update(RaspiSysmonitor) tmr-MQTT2_SERVER_keepaliveChecker(MQTT_Server) tmr-SIRD_Update(MedionRadioLAN) tmr-RESIDENTStk_DurationTimer(Bewohner_DurationTimer) tmr-RESIDENTStk_DurationTimer(rr_Jessica_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Yvonne_DurationTimer) tmr-RESIDENTStk_DurationTimer(rr_Jacqueline_DurationTimer) tmr-RESIDENTStk_DurationTimer(rr_Dieter_DurationTimer) tmr-RESIDENTStk_DurationTimer(rr_Leon_DurationTimer) tmr-SYSSTAT_GetUpdate(SystemStatus) tmr-HOMEMODE_GetUpdate(myHome) tmr-HomeConnect_Timer(Trockner_WT7YH701)
2021.03.14 11:30:38 3: CULHM: Unknown code A062444F9B9EF46, help me!
2021.03.14 11:30:56 3: CULHM: Unknown code A0667E692B9EF46, help me!
2021.03.14 11:30:56 3: CULHM: Unknown code A06B9EF4667E692, help me!
2021.03.14 11:30:57 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.14 11:30:59 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

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

2021.03.14 11:30:59 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.14 11:31:08 3: CUL_HM set RM_Dieter statusRequest noArg
2021.03.14 11:31:13 1: [Freezemon] myFreezemon: possible freeze starting at 11:31:11, delay is 2.819 possibly caused by: tmr-Timer_Check(myTimers) tmr-at_Exec(on_timer_action) tmr-MilightBridge_DoPingStart(MilightBridge) tmr-VestelTVs_PeriodicUpdate(MedionTV)

2021.03.14 11:31:22 1: [Freezemon] myFreezemon: possible freeze starting at 11:31:20, delay is 2.508 possibly caused by: tmr-at_Exec(on_timer_action) tmr-SYSMON_Update(RaspiSysmonitor) tmr-MQTT2_SERVER_keepaliveChecker(MQTT_Server) tmr-RESIDENTStk_DurationTimer(Bewohner_DurationTimer) tmr-SIRD_Update(MedionRadioLAN) tmr-RESIDENTStk_DurationTimer(rr_Jessica_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Yvonne_DurationTimer) tmr-RESIDENTStk_DurationTimer(rr_Jacqueline_DurationTimer) tmr-RESIDENTStk_DurationTimer(rr_Dieter_DurationTimer) tmr-RESIDENTStk_DurationTimer(rr_Leon_DurationTimer) tmr-SYSSTAT_GetUpdate(SystemStatus) tmr-CUL_HM_respPendTout(498DF9) tmr-ONKYO_AVR_connectionCheck(wz_OnkyoReceiver) tmr-HOMEMODE_GetUpdate(myHome) tmr-HomeConnect_Timer(Trockner_WT7YH701) tmr-Shelly_status(Shelly_Dieter_1) tmr-Shelly_status(Shelly_Dieter_2) tmr-Shelly_status(Shelly_wz_Lampe)

2021.03.14 11:31:57 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.03.14 11:32:57 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.14 11:32:59 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

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

2021.03.14 11:32:59 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

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

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

2021.03.14 11:33:01 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.14 11:33:57 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.14 11:33:57 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.58_8080
2021.03.14 11:33:58 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.14 11:33:58 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.14 11:33:58 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.58_8080
2021.03.14 11:33:58 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.14 11:33:58 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.14 11:33:58 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.58_8080-zs-AVTransport
2021.03.14 11:33:58 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-AVTransport, uniquedevice 192.168.178.58_8080, service AVTransport
2021.03.14 11:33:58 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:33:58 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:34:08 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

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

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

2021.03.14 11:34:59 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.



Nun zum Ablauf und die passenden Logs:
~ 11:35 FB on

Code Auswählen Erweitern


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

2021.03.14 11:35:07 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 544.

2021.03.14 11:35:07 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb found. Check for processing
2021.03.14 11:35:07 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb will be controlled with 192.168.178.61_2870
2021.03.14 11:35:07 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: RenderingControl
2021.03.14 11:35:07 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.03.14 11:35:07 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:35:07 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:35:08 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: ConnectionManager
2021.03.14 11:35:08 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: AVTransport
2021.03.14 11:35:08 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.03.14 11:35:08 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:35:08 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:35:08 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:35:08 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:35:08 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:35:08 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:35:09 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0x9df9038) $VAR1 = 'LastChange';
$VAR2 = '<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.14 11:35:09 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.03.14 11:35:09 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.14 11:35:09 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.03.14 11:35:09 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.03.14 11:35:09 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.14 11:35:09 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,
2021.03.14 11:35:09 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:35:09 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0x996e9f8) $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.03.14 11:35:09 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.03.14 11:35:09 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.03.14 11:35:09 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.03.14 11:35:09 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.14 11:35:09 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,


11:36 FB volume von 0 auf 10

Code Auswählen Erweitern


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

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

2021.03.14 11:36:01 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.14 11:36:09 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800


~30 Sekunden später FB Mute on

11:37 FB Mute off

Code Auswählen Erweitern


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

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

2021.03.14 11:36:59 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.14 11:37:09 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800


~30 Sekunden später FB Volume 10 auf 0

11:38 Mehrmaliger Versuch: DLNAController Device mute on - ohne Reaktion in der UI und am TV

Code Auswählen Erweitern


2021.03.14 11:38:09 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.14 11:38:09 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.58_8080
2021.03.14 11:38:09 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.14 11:38:09 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.14 11:38:09 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.58_8080
2021.03.14 11:38:09 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.14 11:38:09 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.14 11:38:09 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.58_8080-zs-AVTransport
2021.03.14 11:38:09 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-AVTransport, uniquedevice 192.168.178.58_8080, service AVTransport
2021.03.14 11:38:09 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:38:09 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:38:15 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, SetMute, 0 Master 1
2021.03.14 11:38:15 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:38:15 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.03.14 11:38:19 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.14 11:38:23 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, SetMute, 0 Master 1
2021.03.14 11:38:23 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:38:23 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.14 11:38:30 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, SetMute, 0 Master 1
2021.03.14 11:38:30 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:38:30 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'}}"


11:39 FB off

Code Auswählen Erweitern


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

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

2021.03.14 11:38:59 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

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

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

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

2021.03.14 11:39:19 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.14 11:39:19 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.61_2870
2021.03.14 11:39:24 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 500 Can't connect to 192.168.178.61:2870 (Connection timed out) at ./FHEM/98_UPNPController.pm line 786.

2021.03.14 11:39:24 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.14 11:39:25 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.61_2870
2021.03.14 11:39:30 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 500 Can't connect to 192.168.178.61:2870 (Connection timed out) at ./FHEM/98_UPNPController.pm line 786.

2021.03.14 11:39:30 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.14 11:39:30 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.61_2870-zs-RenderingControl
2021.03.14 11:39:30 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.03.14 11:39:30 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:39:30 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:39:31 5: UPNPController: warning: Carp, Subscription request failed with error: 500 Can't connect to 192.168.178.61:2870 (No route to host) at ./FHEM/98_UPNPController.pm line 716.

2021.03.14 11:39:31 4: UPNPController: UPNP_Controller: uniqueDeviceName 192.168.178.61_2870 event offline not yet implemented
2021.03.14 11:39:31 3: UPNPController: subscription for service RenderingControl of device 192.168.178.61_2870 failed:


11:41 FB on - DLNA Controller zeigt (wie gehabt) kurz offline und dann wieder online

Code Auswählen Erweitern


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

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

2021.03.14 11:40:59 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.14 11:41:08 3: XiaomiGateway: Reading> SID: 34ce00814818 Type: Gateway RGB: 0
2021.03.14 11:41:08 3: XiaomiGateway: Reading> SID: 34ce00814818 Type: Gateway Illumination: 1080
2021.03.14 11:41:17 1: [Freezemon] myFreezemon: possible freeze starting at 11:41:14, delay is 3.023 possibly caused by: tmr-at_Exec(on_timer_action) tmr-FHEM::AMADDevice::checkDeviceState(iRULUTablet) tmr-VestelTVs_PeriodicUpdate(MedionTV)
2021.03.14 11:41:18 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceRemoved
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller: byebye-notify message device 192.168.178.61_2870 received
2021.03.14 11:41:18 5: UPNPController: earlier subscribed service AVTransport of device 192.168.178.61_2870 went offline
2021.03.14 11:41:18 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|offline|urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:41:18 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|offline|urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:41:18 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, offline, urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, subscribe,
2021.03.14 11:41:18 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:41:18 3: UPNPController: start searching by type with search term: upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, AVTransport, subscribe,
2021.03.14 11:41:18 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:41:18 3: UPNPController: start searching by type with search term: upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: delete redundant search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, SpeakerManagement, subscribe,
2021.03.14 11:41:18 4: UPNPController: SpeakerManagement unknown for UPNP_Controller.
2021.03.14 11:41:18 4: UPNPController: UPNP_Controller, iowrite message received, but service SpeakerManagement not implemented
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, SessionManagement, subscribe,
2021.03.14 11:41:18 4: UPNPController: SessionManagement unknown for UPNP_Controller.
2021.03.14 11:41:18 4: UPNPController: UPNP_Controller, iowrite message received, but service SessionManagement not implemented
2021.03.14 11:41:18 3: DLNAController: DLNA_13cae598_3cca_165a_8000_0009dfbd33fb address changed; services initially subscribed
2021.03.14 11:41:18 3: CULHM: Unknown code A062444F9B9EF46, help me!
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:18 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:19 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceAdded
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller: alive-notify message device uuid:13cae598-3cca-165a-8000-0009dfbd33fb received
2021.03.14 11:41:19 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 544.

2021.03.14 11:41:19 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb found. Check for processing
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb will be controlled with 192.168.178.61_2870
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: RenderingControl
2021.03.14 11:41:19 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.03.14 11:41:19 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:41:19 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: ConnectionManager
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: AVTransport
2021.03.14 11:41:19 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.03.14 11:41:19 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:41:19 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:41:19 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:41:19 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:41:19 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:41:19 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:19 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:19 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xa070180) $VAR1 = 'LastChange';
$VAR2 = '<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.14 11:41: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.03.14 11:41:19 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.14 11:41: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.03.14 11:41: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.03.14 11:41: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.03.14 11:41:19 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,
2021.03.14 11:41:19 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:19 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:19 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:19 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0x9392670) $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.03.14 11:41: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=""/><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.14 11:41: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=""/><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.14 11:41: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=""/><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.14 11:41: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=""/><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.14 11:41:19 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,
2021.03.14 11:41:19 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:19 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:19 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:21 1: [Freezemon] myFreezemon: possible freeze starting at 11:41:20, delay is 1.334 possibly caused by: tmr-at_Exec(on_timer_action) tmr-UPNPController_renewSubscriptions(UPNP_Controller) tmr-MQTT2_SERVER_keepaliveChecker(MQTT_Server) tmr-SIRD_Update(MedionRadioLAN)
2021.03.14 11:41:21 3: myTimers: time difference too large! interval=9, Sekunde=21
2021.03.14 11:41:21 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:21 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:21 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:21 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:21 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:21 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:21 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:22 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:22 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:22 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:24 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:24 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:24 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:24 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:24 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:24 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:24 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:24 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:24 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:26 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:26 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:26 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:28 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:28 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:28 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:41 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:41 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:41 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:41 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:41 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:41 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:41 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:41 4: UPNPController: discovery message of Jellyfin - MediaNAS with UDN: uuid:1a1c5a4be39a463781c3b63d5569ce56 action: deviceAdded
2021.03.14 11:41:41 5: UPNPController: UPNP_Controller: alive-notify message device uuid:1a1c5a4be39a463781c3b63d5569ce56 received
2021.03.14 11:41:41 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 544.

2021.03.14 11:41:41 5: UPNPController: warning: main, Use of uninitialized value in string eq at ./FHEM/98_UPNPController.pm line 544.

2021.03.14 11:41:41 5: UPNPController: UPNP_Controller: device uuid:1a1c5a4be39a463781c3b63d5569ce56 found. Check for processing
2021.03.14 11:41:41 5: UPNPController: UPNP_Controller: device uuid:1a1c5a4be39a463781c3b63d5569ce56 will be controlled with 192.168.178.77_8096
2021.03.14 11:41:41 5: UPNPController: UPNP_Controller: device uuid:1a1c5a4be39a463781c3b63d5569ce56 has service with serviceId: ContentDirectory
2021.03.14 11:41:41 5: UPNPController: UPNP_Controller: device uuid:1a1c5a4be39a463781c3b63d5569ce56 has service with serviceId: ConnectionManager
2021.03.14 11:41:41 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:41 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:42 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:42 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:42 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:42 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:42 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:42 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:42 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all
2021.03.14 11:41:44 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:41:44 5: UPNPController: UPNP_Controller, received search response on pending search request upnp:rootdevice
2021.03.14 11:41:44 5: UPNPController: UPNP_Controller, received search response on pending search request ssdp:all


11:42 FB off
[code]
2021.03.14 11:42:01 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

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

2021.03.14 11:42:01 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.14 11:42:19 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.14 11:42:19 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.58_8080

[KölnSolar]

Hallo Dieter,

Danke fürs akribische Testen. Nun ist einiges klarer.

Erstmal zum Radio

Code Auswählen Erweitern

2021.03.14 11:29:47 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-AVTransport, uniquedevice 192.168.178.58_8080, service AVTransport
2021.03.14 11:29:47 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-RenderingControl, uniquedevice 192.168.178.58_8080, service RenderingControl
2021.03.14 11:29:48 5: UPNP_Controller: dispatch RenderingControl|192.168.178.58_8080|online|urn:schemas-upnp-org:metadata-1-0/RCSDie Erkennung ist OK. Aber dann

Code Auswählen Erweitern

2021.03.14 11:33:58 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.58_8080
2021.03.14 11:33:58 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.
"Heilt" sich dann selber

Code Auswählen Erweitern

2021.03.14 11:33:58 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
.
2021.03.14 11:33:58 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-AVTransport, uniquedevice 192.168.178.58_8080, service AVTransport
Steht im UPNPController im servicereading timeout: 300 ? Seltsam, dass das in die Hose ging. 

zum TV

Von dem Helper Device sehe ich keine Logeinträge.

Doch.

Code Auswählen Erweitern

2021.03.14 11:35:08 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
.....nun wird im für uns unsichtbaren perl-Paket verarbeitet und dann an UPNP_Controller übergeben
2021.03.14 11:35:09 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>
....Übergabe an DLNAController
2021.03.14 11:35:09 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>
....und schließlich zurück zum UPNPController-socketdevice
2021.03.14 11:35:09 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,

online/offline scheinen zu funktionieren. Zwar merkt der UPNPController

Code Auswählen Erweitern

2021.03.14 11:39:19 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.61_2870
2021.03.14 11:39:24 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 500 Can't connect to 192.168.178.61:2870 (Connection timed out) at ./FHEM/98_UPNPController.pm line 786.

2021.03.14 11:39:24 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.14 11:39:25 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.61_2870
2021.03.14 11:39:30 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 500 Can't connect to 192.168.178.61:2870 (Connection timed out) at ./FHEM/98_UPNPController.pm line 786.

2021.03.14 11:39:30 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.14 11:39:30 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.61_2870-zs-RenderingControl
2021.03.14 11:39:30 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.03.14 11:39:30 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:39:30 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:39:31 5: UPNPController: warning: Carp, Subscription request failed with error: 500 Can't connect to 192.168.178.61:2870 (No route to host) at ./FHEM/98_UPNPController.pm line 716.

2021.03.14 11:39:31 4: UPNPController: UPNP_Controller: uniqueDeviceName 192.168.178.61_2870 event offline not yet implementeddass abgeschaltet wurde zuerst(ich muss mal gucken, warum das nicht zum dispatch des offline-status, sondern fälschlicherweise

Code Auswählen Erweitern

event offline not yet implementedergibt). Aber dann kommt(vermeintlich beim wiedereinschalten) die verspätete bye-bye-message

Code Auswählen Erweitern

2021.03.14 11:41:18 4: UPNPController: discovery message of ALDISUED TV with UDN: uuid:13cae598-3cca-165a-8000-0009dfbd33fb action: deviceRemoved
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller: byebye-notify message device 192.168.178.61_2870 received
2021.03.14 11:41:18 5: UPNPController: earlier subscribed service AVTransport of device 192.168.178.61_2870 went offline
2021.03.14 11:41:18 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|offline|urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:41:18 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|offline|urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:41:18 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, offline, urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:41:18 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, subscribe,
2021.03.14 11:41:18 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.Ich vermute, dass das wie bei den Samsungs ist: Nach dem Abschalten dauert es knappe 3' bis der TV wirklich offline ist.

DLNAController Device mute on

Klappt nicht

Code Auswählen Erweitern

2021.03.14 11:38:15 5: UPNPController: UPNP_Controller, 192.168.178.61_2870, RenderingControl, SetMute, 0 Master 1
2021.03.14 11:38:15 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:38:15 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'}}"Hattest Du oder Eki im anderen Thread das xml zum RenderingControl bereits gepostet ? gefunden.Da muss ich mir mal die Details ansehen.

Unsäglich, dass events nach der subscription kommen, dann aber bei der FB keine Reaktion mehr erfolgt. Da hab ich keine Idee, denn das

Code Auswählen Erweitern

2021.03.14 11:35:07 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.03.14 11:35:07 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:35:07 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.14 11:35:08 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: ConnectionManager
2021.03.14 11:35:08 5: UPNPController: UPNP_Controller: device uuid:13cae598-3cca-165a-8000-0009dfbd33fb has service with serviceId: AVTransport
2021.03.14 11:35:08 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.03.14 11:35:08 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:35:08 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.14 11:35:08 5: UPNP_Controller: dispatch AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:35:08 5: DLNAController: message from UPNP_Controller, message: AVTransport|192.168.178.61_2870|online|urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:35:08 4: DLNAController: message parameters: AVTransport, 192.168.178.61_2870, online, urn:schemas-upnp-org:metadata-1-0/AVT
2021.03.14 11:35:08 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.14 11:35:09 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0x9df9038) $VAR1 = 'LastChange';
$VAR2 = '<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.14 11:35:09 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"/><ist absolut OK und wenn Du mir zwischen 11:35:09 u. dem ersten Volumebefehl per FB keine Logeinträge verschwiegen hast, ist der TV angewiesen Veränderungen zu melden. Bitte auch hier im UPNP_Controller mal die timeouts der services ansehen.

Vielleicht kann Eki mit seiner Vestel-Erfahrung ja ad-hoc was dazu sagen.

Hattest Du den UPNP_Controller "nackt" oder mit den Attributen envNamespace u. envPrefix laufen ?  Dürfte aber meines Erachtens bei diesen Tests sowieso keine Auswirkung haben.

Grüße Markus

Edit: den Fehler

event offline not yet implemented

hab ich gefunden.
Wie sind Radio u. Tv angebunden ? LAN o. Wifi ?
Edit2: Ich wird verrückt. Im xml steht

Code Auswählen Erweitern

<stateVariable sendEvents="yes">
</stateVariable>Müsste aber so

Code Auswählen Erweitern

<stateVariable sendEvents="yes">
<name>LastChange</name>
<dataType>string</dataType>
</stateVariable>aussehen.  Ist das in 192.168.178.61:2870/dmr_avts.xml auch so ?
Eki: Bei Dir genauso ?

[RockFan]

Hallo Markus,

Danke für die ausführliche Analyse und das Suchen

Ich versuche mal ein paar Antworten/Kommentare zu geben (alle schaffe ich jetzt nicht mehr).

Mit dem Medion-Radio hatte ich gar keine Tests gemacht, aber da könnte ich vielleicht morgen Abend noch etwas nachliefern.

Bitte auch hier im UPNP_Controller mal die timeouts der services ansehen.

Ich finde beim Radio und beim TV in den Readings jeweils einen Eintrag über 300:

Radio:

Code Auswählen Erweitern

192.168.178.58_8080-zs-RenderingControl                          subscription committed, timeout: 300

TV:

Code Auswählen Erweitern

192.168.178.61_2870-zs-AVTransport                               SID: uuid:13cfe458-7cfa-1200-8000-d22f0876b858 timeout: 300 property: LastChange

Hattest Du den UPNP_Controller "nackt" oder mit den Attributen envNamespace u. envPrefix laufen ?

Die beiden Attribute waren nicht mehr gesetzt. Hatte wohl beim letzten Testen das Speichern vergessen 
Sollte ich sie grundsätzlich wieder setzen?

Wie sind Radio u. Tv angebunden ? LAN o. Wifi ?

Beide sind per LAN angeschlossen.

Die 192.168.178.61:2870/dmr_avts.xml versuche ich dann morgen nachzuliefern.

Viele Grüße
Dieter

[KölnSolar]

Morgen Dieter,

Sollte ich sie grundsätzlich wieder setzen?

Nein. Die sind quasi bereits eine Modifikation des Codes. Wenn die Tests durch sind, kann man schnell u. einfach gucken, ob sich durch die Attribute etwas bessert.

Mit dem Medion-Radio hatte ich gar keine Tests gemacht

Schon klar. Aber wenn ich Fehler im Log sehe....

192.168.178.58_8080-zs-RenderingControl                          subscription committed, timeout: 300

heißt: subscription angenommen, es kam aber kein Änderungs-event hinterher.

Code Auswählen Erweitern

192.168.178.61_2870-zs-AVTransport                               SID: uuid:13cfe458-7cfa-1200-8000-d22f0876b858 timeout: 300 property: LastChangeSo sollte es im Grundsatz immer aussehen, wenn ein DLNAdevice online ist.

Ich sah in Deinen Logs ne Menge starker freezes. Ich hoffe die sind nicht vom UPnP-Gedöns. Mach bitte mal ne statistische Aussage dazu, um Dein System besser zu verstehen.

Grüße Markus

Edit: Teste mal das Gleiche mit dem Mediaplayer. Technisch erklärbar wäre dasselbe Verhalten: keine events. Also FB volume/mute ändert nichts im Mediaplayer am PC.

[RockFan]

Hallo Markus,

zuerst mal das versprochene XML (192.168.178.61:2870/dmr_avts.xml), in dem es nach meinem Verständnis besser aussieht:

Code Auswählen Erweitern


<scpd>
<specVersion>
<major>1</major>
<minor>0</minor>
</specVersion>
<serviceStateTable>
<stateVariable sendEvents="no">
<name>TransportState</name>
<dataType>string</dataType>
<allowedValueList>
<allowedValue>STOPPED</allowedValue>
<allowedValue>PAUSED_PLAYBACK</allowedValue>
<allowedValue>PLAYING</allowedValue>
<allowedValue>TRANSITIONING</allowedValue>
<allowedValue>NO_MEDIA_PRESENT</allowedValue>
</allowedValueList>
</stateVariable>
<stateVariable sendEvents="no">
<name>TransportStatus</name>
<dataType>string</dataType>
<allowedValueList>
<allowedValue>OK</allowedValue>
<allowedValue>ERROR_OCCURRED</allowedValue>
</allowedValueList>
</stateVariable>
<stateVariable sendEvents="no">
<name>PlaybackStorageMedium</name>
<dataType>string</dataType>
<allowedValueList>
<allowedValue>NONE</allowedValue>
<allowedValue>NETWORK</allowedValue>
</allowedValueList>
</stateVariable>
<stateVariable sendEvents="no">
<name>RecordStorageMedium</name>
<dataType>string</dataType>
<allowedValueList>
<allowedValue>NOT_IMPLEMENTED</allowedValue>
</allowedValueList>
</stateVariable>
<stateVariable sendEvents="no">
<name>PossiblePlaybackStorageMedia</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>PossibleRecordStorageMedia</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>CurrentPlayMode</name>
<dataType>string</dataType>
<allowedValueList>
<allowedValue>NORMAL</allowedValue>
</allowedValueList>
<defaultValue>NORMAL</defaultValue>
</stateVariable>
<stateVariable sendEvents="no">
<name>TransportPlaySpeed</name>
<dataType>string</dataType>
<allowedValueList>
<allowedValue>1/16</allowedValue>
<allowedValue>1/8</allowedValue>
<allowedValue>1/4</allowedValue>
<allowedValue>1/2</allowedValue>
<allowedValue>-1/2</allowedValue>
<allowedValue>-1/4</allowedValue>
<allowedValue>-1/8</allowedValue>
<allowedValue>-1/16</allowedValue>
<allowedValue>1</allowedValue>
<allowedValue>2</allowedValue>
<allowedValue>4</allowedValue>
<allowedValue>8</allowedValue>
<allowedValue>16</allowedValue>
<allowedValue>-2</allowedValue>
<allowedValue>-4</allowedValue>
<allowedValue>-8</allowedValue>
<allowedValue>-16</allowedValue>
</allowedValueList>
</stateVariable>
<stateVariable sendEvents="no">
<name>X_DLNA_RelativeBytePosition</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>X_DLNA_AbsoluteBytePosition</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>X_DLNA_CurrentTrackSize</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>RecordMediumWriteStatus</name>
<dataType>string</dataType>
<allowedValueList>
<allowedValue>NOT_IMPLEMENTED</allowedValue>
</allowedValueList>
</stateVariable>
<stateVariable sendEvents="no">
<name>CurrentRecordQualityMode</name>
<dataType>string</dataType>
<allowedValueList>
<allowedValue>NOT_IMPLEMENTED</allowedValue>
</allowedValueList>
</stateVariable>
<stateVariable sendEvents="no">
<name>PossibleRecordQualityModes</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>NumberOfTracks</name>
<dataType>ui4</dataType>
<allowedValueRange>
<minimum>0</minimum>
<maximum>65535</maximum>
</allowedValueRange>
</stateVariable>
<stateVariable sendEvents="no">
<name>CurrentTrack</name>
<dataType>ui4</dataType>
<allowedValueRange>
<minimum>0</minimum>
<maximum>65535</maximum>
<step>1</step>
</allowedValueRange>
</stateVariable>
<stateVariable sendEvents="no">
<name>CurrentTrackDuration</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>CurrentMediaDuration</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>CurrentTrackMetaData</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>CurrentTrackURI</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>AVTransportURI</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>AVTransportURIMetaData</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>NextAVTransportURI</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>NextAVTransportURIMetaData</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>RelativeTimePosition</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>AbsoluteTimePosition</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>RelativeCounterPosition</name>
<dataType>i4</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>AbsoluteCounterPosition</name>
<dataType>i4</dataType>
</stateVariable>
<stateVariable sendEvents="yes">
<name>LastChange</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>A_ARG_TYPE_SeekMode</name>
<dataType>string</dataType>
<allowedValueList>
<allowedValue>ABS_TIME</allowedValue>
<allowedValue>REL_TIME</allowedValue>
<allowedValue>ABS_COUNT</allowedValue>
<allowedValue>REL_COUNT</allowedValue>
<allowedValue>TRACK_NR</allowedValue>
</allowedValueList>
</stateVariable>
<stateVariable sendEvents="no">
<name>A_ARG_TYPE_SeekTarget</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>A_ARG_TYPE_InstanceID</name>
<dataType>ui4</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>CurrentTransportActions</name>
<dataType>string</dataType>
</stateVariable>
</serviceStateTable>
<actionList>
<action>
<name>SetAVTransportURI</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
<argument>
<name>CurrentURI</name>
<direction>in</direction>
<relatedStateVariable>AVTransportURI</relatedStateVariable>
</argument>
<argument>
<name>CurrentURIMetaData</name>
<direction>in</direction>
<relatedStateVariable>AVTransportURIMetaData</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>GetMediaInfo</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
<argument>
<name>NrTracks</name>
<direction>out</direction>
<relatedStateVariable>NumberOfTracks</relatedStateVariable>
</argument>
<argument>
<name>MediaDuration</name>
<direction>out</direction>
<relatedStateVariable>CurrentMediaDuration</relatedStateVariable>
</argument>
<argument>
<name>CurrentURI</name>
<direction>out</direction>
<relatedStateVariable>AVTransportURI</relatedStateVariable>
</argument>
<argument>
<name>CurrentURIMetaData</name>
<direction>out</direction>
<relatedStateVariable>AVTransportURIMetaData</relatedStateVariable>
</argument>
<argument>
<name>NextURI</name>
<direction>out</direction>
<relatedStateVariable>NextAVTransportURI</relatedStateVariable>
</argument>
<argument>
<name>NextURIMetaData</name>
<direction>out</direction>
<relatedStateVariable>NextAVTransportURIMetaData</relatedStateVariable>
</argument>
<argument>
<name>PlayMedium</name>
<direction>out</direction>
<relatedStateVariable>PlaybackStorageMedium</relatedStateVariable>
</argument>
<argument>
<name>RecordMedium</name>
<direction>out</direction>
<relatedStateVariable>RecordStorageMedium</relatedStateVariable>
</argument>
<argument>
<name>WriteStatus</name>
<direction>out</direction>
<relatedStateVariable>RecordMediumWriteStatus</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>GetTransportInfo</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
<argument>
<name>CurrentTransportState</name>
<direction>out</direction>
<relatedStateVariable>TransportState</relatedStateVariable>
</argument>
<argument>
<name>CurrentTransportStatus</name>
<direction>out</direction>
<relatedStateVariable>TransportStatus</relatedStateVariable>
</argument>
<argument>
<name>CurrentSpeed</name>
<direction>out</direction>
<relatedStateVariable>TransportPlaySpeed</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>GetPositionInfo</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
<argument>
<name>Track</name>
<direction>out</direction>
<relatedStateVariable>CurrentTrack</relatedStateVariable>
</argument>
<argument>
<name>TrackDuration</name>
<direction>out</direction>
<relatedStateVariable>CurrentTrackDuration</relatedStateVariable>
</argument>
<argument>
<name>TrackMetaData</name>
<direction>out</direction>
<relatedStateVariable>CurrentTrackMetaData</relatedStateVariable>
</argument>
<argument>
<name>TrackURI</name>
<direction>out</direction>
<relatedStateVariable>CurrentTrackURI</relatedStateVariable>
</argument>
<argument>
<name>RelTime</name>
<direction>out</direction>
<relatedStateVariable>RelativeTimePosition</relatedStateVariable>
</argument>
<argument>
<name>AbsTime</name>
<direction>out</direction>
<relatedStateVariable>AbsoluteTimePosition</relatedStateVariable>
</argument>
<argument>
<name>RelCount</name>
<direction>out</direction>
<relatedStateVariable>RelativeCounterPosition</relatedStateVariable>
</argument>
<argument>
<name>AbsCount</name>
<direction>out</direction>
<relatedStateVariable>AbsoluteCounterPosition</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>GetDeviceCapabilities</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
<argument>
<name>PlayMedia</name>
<direction>out</direction>
<relatedStateVariable>PossiblePlaybackStorageMedia</relatedStateVariable>
</argument>
<argument>
<name>RecMedia</name>
<direction>out</direction>
<relatedStateVariable>PossibleRecordStorageMedia</relatedStateVariable>
</argument>
<argument>
<name>RecQualityModes</name>
<direction>out</direction>
<relatedStateVariable>PossibleRecordQualityModes</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>GetTransportSettings</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
<argument>
<name>PlayMode</name>
<direction>out</direction>
<relatedStateVariable>CurrentPlayMode</relatedStateVariable>
</argument>
<argument>
<name>RecQualityMode</name>
<direction>out</direction>
<relatedStateVariable>CurrentRecordQualityMode</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>GetCurrentTransportActions</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
<argument>
<name>Actions</name>
<direction>out</direction>
<relatedStateVariable>CurrentTransportActions</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>Stop</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>Play</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
<argument>
<name>Speed</name>
<direction>in</direction>
<relatedStateVariable>TransportPlaySpeed</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>Pause</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>Seek</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
<argument>
<name>Unit</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_SeekMode</relatedStateVariable>
</argument>
<argument>
<name>Target</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_SeekTarget</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>Next</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>Previous</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
</argumentList>
</action>
<action>
<name>X_DLNA_GetBytePositionInfo</name>
<argumentList>
<argument>
<name>InstanceID</name>
<direction>in</direction>
<relatedStateVariable>A_ARG_TYPE_InstanceID</relatedStateVariable>
</argument>
<argument>
<name>TrackSize</name>
<direction>out</direction>
<relatedStateVariable>X_DLNA_CurrentTrackSize</relatedStateVariable>
</argument>
<argument>
<name>RelByte</name>
<direction>out</direction>
<relatedStateVariable>X_DLNA_RelativeBytePosition</relatedStateVariable>
</argument>
<argument>
<name>AbsByte</name>
<direction>out</direction>
<relatedStateVariable>X_DLNA_AbsoluteBytePosition</relatedStateVariable>
</argument>
</argumentList>
</action>
</actionList>
</scpd>


Seit ich vor wahrscheinlich 3 Jahren FREEZEMON aktiviert habe, habe ich die regelmäßigen Einträge im Log. Ich würde mal sagen pro Minute ein Eintrag. Die Diskussionen habe ich aufmerksam verfolgt. Manches hat mir auch geholfen, aber mir fehlte von Anfang an die Relation. Ich glaube auch, dass das gar nicht so einfach zu bewerten ist. Mein System ist über die vielen Jahre letztendlich auch imens gewachsen. Den count, den ich gerade mal angestoßen hat ergibt 884 Devices. Wichtig war mir immer, dass das System möglichst rund läuft und das tat es zumeist.

Teste mal das Gleiche mit dem Mediaplayer. Technisch erklärbar wäre dasselbe Verhalten: keine events. Also FB volume/mute ändert nichts im Mediaplayer am PC.

Du sprichst doch vom Mediaplayer auf meinem PC, oder? Wie meinst Du das mit FB?

Jetzt habe ich gerade mal beim Radio noch Mute und Volume mit der Fernbedienung probiert und ins Log geschaut (verbose=5 ist von gestern noch gesetzt) und ich sehe dazu gar nichts passendes. Einzige zeitlich zu meinen etwas früher durchgeführten Aktionen nicht passende Einträge:

Code Auswählen Erweitern


2021.03.15 21:27:28 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.15 21:27:28 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.58_8080
2021.03.15 21:27:28 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.15 21:27:28 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.15 21:27:28 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.58_8080
2021.03.15 21:27:28 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.15 21:27:28 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.15 21:27:29 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.58_8080-zs-AVTransport
2021.03.15 21:27:29 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-AVTransport, uniquedevice 192.168.178.58_8080, service AVTransport
2021.03.15 21:27:29 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.15 21:27:29 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.15 21:27:39 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800


Viele Grüße
Dieter

[KölnSolar]

Hi Dieter,

Du sprichst doch vom Mediaplayer auf meinem PC, oder? Wie meinst Du das mit FB?

Genau. Wenn Du auf den TV streamst, sollte sich ein mute/volume per Fb auch im Mediaplayer zeigen.

in dem es nach meinem Verständnis besser aussieht

Ja. Mit dem Mediaplayer einen stream abgespielt, sollten sich die readings im DLNAController device entsprechend verändern.

ich sehe dazu gar nichts passendes

Kann auch nicht, da

Code Auswählen Erweitern

2021.03.15 21:27:28 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition FailedDa ist die Frage warum es fehl schlägt und ob es bis zum ersten renewal funktioniert. Letzteres kannst Du testen, indem Du

Code Auswählen Erweitern

set UPNP_Controller verbose 5
set UPNP_Controller subscribe 192.168.178.58_8080-zs-RenderingControlausführst. Dadurch wird neu subscribed und dann mal sofort ein paar Befehle per Hardware(FB...) absetzen. Aussergewöhnlich war ja schon

Zitat
192.168.178.58_8080-zs-RenderingControl                          subscription committed, timeout: 300
heißt: subscription angenommen, es kam aber kein LastChange-event hinterher.

Und ich dachte darüber nach, ob die freezes Schuld sein könnten. Ich denke aber nicht. Auch hier könntest Du wieder mit dem Mediaplayer vergleichen. Der hat auch ein subscription timeout von 300.

Wichtig war mir immer, dass das System möglichst rund läuft und das tat es zumeist.

Da stimme ich Dir zu. Aber permanente freezes sind keine Freude, wenn man zeitnah(z.B. Klingeltaster über FHEM indirekt mit Klingel, CAM-Bild auf TV...) gekoppelt hat. Dann ist der Besucher weg, bevor man es gemerkt hat.  In der Regel sind die Module schuld. Deshalb hatte ich den DLNARenderer bzgl. subscription-renewal und GPIO4 modifiziert, damit sie nicht mehr blockieren. Das hiesige Projekt soll dann allem was mit UPnP zu tun hat, die Möglichkeit geben, nicht blockierend zu arbeiten.

Grüße Markus

[RockFan]

Hallo Markus,

Tests mit TV und Mediaplayer werde ich wahrscheinlich erst am Wochenende schaffen.

Die Erneuerung der Subscription für das Radio habe ich gerade mit folgendem Log-Ergebnis ausprobiert (die letzten 3 Einträge hätte ich mir wahrscheinlich sparen können  ):

Code Auswählen Erweitern


2021.03.16 23:09:48 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.16 23:10:03 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-RenderingControl, uniquedevice 192.168.178.58_8080, service RenderingControl
2021.03.16 23:10:03 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.16 23:10:03 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.16 23:10:13 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.16 23:10:16 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.03.16 23:10:16 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.03.16 23:10:16 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.


Gleich nach dem Subscribe habe ich auf der FB wild Mute, Unmute, Volume gesendet.

Bzgl. der Freezes bin ich ja auch immer dankbar, wenn schön langsam Blockings aus den Modulen verschwinden. Wahrscheinlich kommen mit neuen Modulen aber auch wieder einige hinzu 

Viele Grüße
Dieter

[KölnSolar]

Hi Dieter,

Tests mit TV und Mediaplayer werde ich wahrscheinlich erst am Wochenende schaffen.

Völlig OK.

Die Erneuerung der Subscription für das Radio habe ich gerade mit folgendem Log-Ergebnis ausprobiert

Ich habs befürchtet.
Kannst Du auch da mal in den xml-files nach "LastChange" gucken.

Grüße Markus

[RockFan]

Hi Markus,

in der http://192.168.178.58:8080/AVTransport/scpd.xml finde ich

Code Auswählen Erweitern


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


In http://192.168.178.58:8080/ConnectionManager/scpd.xml gibt es trotz mehrerer sendEvents="yes" kein LastChange:

Code Auswählen Erweitern


<stateVariable sendEvents="yes">
<name>SourceProtocolInfo</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="yes">
<name>SinkProtocolInfo</name>
<dataType>string</dataType>
</stateVariable>
<stateVariable sendEvents="no">
<name>A_ARG_TYPE_Direction</name>
<dataType>string</dataType>
<allowedValueList>
<allowedValue>Output</allowedValue>
<allowedValue>Input</allowedValue>
</allowedValueList>
</stateVariable>
<stateVariable sendEvents="yes">
<name>CurrentConnectionIDs</name>
<dataType>string</dataType>
</stateVariable>


Und in http://192.168.178.58:8080/RenderingControl/scpd.xml gibt es wieder einen gesuchten Eintrag:

Code Auswählen Erweitern


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


Gib bitte Bescheid, wenn ich die kompletten XMLs posten soll.

Viele Grüße
Dieter

[KölnSolar]

Hi Dieter,
schon gut so. Der ConnectionManager interessiert uns nicht. Die anderen sind OK. Ich hab keine Idee, warum es dann nicht tut was man ihm sagt.  Dann bleibt der Mediaplayer zum vergleichen, ob der schlauer ist. Wenn ja, könnte man die Kommunikation per Wireshark mitschneiden, um dem auf den Grund zu gehen.
Grüße Markus

[RockFan]

Hallo Markus,

ich habe gerade mal die Tests mit dem Windows Mediaplayer begonnen.

Erster Test mit dem Radio und dem Mediaplayer (IP 192.168.178.85) auf meinem PC (IP 192.168.178.105). Das Streaming habe ich um 11:40 begonnen und dann unmittelbar auf der FB mit Mute und Volume gespielt. Die Aktionen auf der FB wirken natürlich auf dem Radio selbst. Im Mediaplayer war davon aber nichts zu sehen. Am Ende des Tests habe ich dann noch Mute und Volume vom Mediaplayer verwendet, um zu sehen, ob es am Radio ankommt (was es auch tat).

Im Log findet sich Folgendes (ich habe ein Zeilen, die mit Sicherheit nichts mit dem Ergebnis zu tun haben (Freeze, andere Devices) ausgelassen):

Code Auswählen Erweitern


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

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

2021.03.21 11:40:17 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.21 11:40:19 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 11:41:19 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 11:41:19 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.58_8080
2021.03.21 11:41:19 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 11:41:19 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.21 11:41:19 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.58_8080
2021.03.21 11:41:19 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 11:41:19 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.21 11:41:19 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.105_2869
2021.03.21 11:41:19 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.58_8080-zs-RenderingControl
2021.03.21 11:41:19 4: UPNPController: subscribe: reading  192.168.178.58_8080-zs-RenderingControl, uniquedevice 192.168.178.58_8080, service RenderingControl
2021.03.21 11:41:19 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.21 11:41:19 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.21 11:41:29 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 11:41:46 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

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

2021.03.21 11:41:46 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.


In Kürze mache ich noch den Test mit dem TV. Allerdings mit dem Mediaplayer auf dem Mediacenter-PC im Wohnzimmer und werde das Ergebnis berichten.

Viele Grüße
Dieter

[RockFan]

... und nun der TV-Test. Dieser gestaltet sich etwas schwieriger, da das Fernsehgerät auch gleichzeitig der Monitor des PCs ist und durch das Streamen (selbst bei Musik) natürlich das Bild zum Stream wechselt. Beobachtungen konnte ich dann nur mit Hilfe von VNC machen. Letztere decken sich mit dem Radio. Mute und Volume über die FB sehe ich nicht im Mediaplayer. Allerdings sind deutlich mehr Logeinträge mit mehr Infos zu sehen:

Code Auswählen Erweitern


2021.03.21 12:13:52 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 12:13:52 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.58_8080
2021.03.21 12:13:52 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:13:52 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.21 12:13:52 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.58_8080
2021.03.21 12:13:52 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:13:52 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.21 12:13:52 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.61_2870
2021.03.21 12:13:52 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:13:52 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.21 12:13:52 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.61_2870
2021.03.21 12:13:52 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:13:52 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.21 12:13:52 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.61_2870-zs-RenderingControl
2021.03.21 12:13:52 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.03.21 12:13:52 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.21 12:13:52 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.21 12:13:52 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.21 12:13:52 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xb077848) $VAR1 = 'LastChange';
$VAR2 = '<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.21 12:13:52 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.03.21 12:13:52 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.03.21 12:13:52 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.03.21 12:13:52 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.21 12:13:52 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,
2021.03.21 12:14:02 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 12:14:20 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.03.21 12:14:20 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.03.21 12:14:20 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

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

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

2021.03.21 12:14:50 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.21 12:15:02 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 12:15:02 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.105_2869
2021.03.21 12:16:02 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 12:16:20 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.03.21 12:16:20 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.03.21 12:16:20 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.21 12:16:56 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.21 12:16:56 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xb077848) $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;Volume channel=&quot;Master&quot; val=&quot;1&quot;/&gt;&lt;VolumeDB channel=&quot;Master&quot; val=&quot;-32112&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.03.21 12:16:56 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"><Volume channel="Master" val="1"/><VolumeDB channel="Master" val="-32112"/></InstanceID></Event>
2021.03.21 12:16:56 5: UPNP_Controller: dispatch RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume channel="Master" val="1"/><VolumeDB channel="Master" val="-32112"/></InstanceID></Event>
2021.03.21 12:16:56 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"><Volume channel="Master" val="1"/><VolumeDB channel="Master" val="-32112"/></InstanceID></Event>
2021.03.21 12:16:56 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume channel="Master" val="1"/><VolumeDB channel="Master" val="-32112"/></InstanceID></Event>
2021.03.21 12:16:56 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,
2021.03.21 12:16:56 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.21 12:16:56 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xb077848) $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;Volume channel=&quot;Master&quot; val=&quot;20&quot;/&gt;&lt;VolumeDB channel=&quot;Master&quot; val=&quot;-19661&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.03.21 12:16:56 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"><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/></InstanceID></Event>
2021.03.21 12:16:56 5: UPNP_Controller: dispatch RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/></InstanceID></Event>
2021.03.21 12:16:56 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"><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/></InstanceID></Event>
2021.03.21 12:16:56 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/></InstanceID></Event>
2021.03.21 12:16:56 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,
2021.03.21 12:16:56 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.21 12:16:56 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xb077848) $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;Volume channel=&quot;Master&quot; val=&quot;21&quot;/&gt;&lt;VolumeDB channel=&quot;Master&quot; val=&quot;-19005&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.03.21 12:16:56 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"><Volume channel="Master" val="21"/><VolumeDB channel="Master" val="-19005"/></InstanceID></Event>
2021.03.21 12:16:56 5: UPNP_Controller: dispatch RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume channel="Master" val="21"/><VolumeDB channel="Master" val="-19005"/></InstanceID></Event>
2021.03.21 12:16:56 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"><Volume channel="Master" val="21"/><VolumeDB channel="Master" val="-19005"/></InstanceID></Event>
2021.03.21 12:16:56 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume channel="Master" val="21"/><VolumeDB channel="Master" val="-19005"/></InstanceID></Event>
2021.03.21 12:16:57 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,
2021.03.21 12:17:02 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.21 12:17:02 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xb077848) $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;Volume channel=&quot;Master&quot; val=&quot;20&quot;/&gt;&lt;VolumeDB channel=&quot;Master&quot; val=&quot;-19661&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.03.21 12:17:02 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"><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/></InstanceID></Event>
2021.03.21 12:17:02 5: UPNP_Controller: dispatch RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/></InstanceID></Event>
2021.03.21 12:17:02 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"><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/></InstanceID></Event>
2021.03.21 12:17:02 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume channel="Master" val="20"/><VolumeDB channel="Master" val="-19661"/></InstanceID></Event>
2021.03.21 12:17:02 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,
2021.03.21 12:17:02 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.21 12:17:02 5: UPNPController: Received event: by 192.168.178.61_2870-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0xb077848) $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;Volume channel=&quot;Master&quot; val=&quot;0&quot;/&gt;&lt;VolumeDB channel=&quot;Master&quot; val=&quot;-32768&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.03.21 12:17:02 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"><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/></InstanceID></Event>
2021.03.21 12:17:02 5: UPNP_Controller: dispatch RenderingControl|192.168.178.61_2870|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/></InstanceID></Event>
2021.03.21 12:17:02 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"><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/></InstanceID></Event>
2021.03.21 12:17:02 4: DLNAController: message parameters: RenderingControl, 192.168.178.61_2870, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Volume channel="Master" val="0"/><VolumeDB channel="Master" val="-32768"/></InstanceID></Event>
2021.03.21 12:17:02 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 12:17:02 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.38_2869
2021.03.21 12:17:02 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,

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

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

2021.03.21 12:17:50 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.21 12:18:02 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 12:18:02 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.58_8080
2021.03.21 12:18:02 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:18:02 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.21 12:18:02 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.58_8080
2021.03.21 12:18:02 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:18:02 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.21 12:18:02 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.61_2870
2021.03.21 12:18:03 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:18:03 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.21 12:18:03 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.61_2870
2021.03.21 12:18:03 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.61_2870-zs-AVTransport
2021.03.21 12:18:03 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-AVTransport, uniquedevice 192.168.178.61_2870, service AVTransport
2021.03.21 12:18:03 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.21 12:18:03 5: UPNPController: AVTransport: urn:schemas-upnp-org:service:AVTransport:1 found. OK.
2021.03.21 12:18:03 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.21 12:18:03 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xb382a00) $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.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.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; xmlns:microsoft=&amp;quot;urn:schemas-microsoft-com:WMPNSS-1-0/&amp;quot; xmlns:dlna=&amp;quot;urn:schemas-dlna-org:metadata-1-0/&amp;quot;&amp;gt;&amp;lt;item id=&amp;quot;1000&amp;quot; restricted=&amp;quot;1&amp;quot; parentID=&amp;quot;0&amp;quot; microsoft:cpId=&amp;quot;{372B6B86-7E04-4D97-9C9A-51337A7B214B}&amp;quot; microsoft:trackId=&amp;quot;1&amp;quot;&amp;gt;&amp;lt;dc:title&amp;gt;Violin Concertos KV 364-190&amp;lt;/dc:title&amp;gt;&amp;lt;dc:creator&amp;gt;Mozart&amp;lt;/dc:creator&amp;gt;&amp;lt;res size=&amp;quot;73025024&amp;quot; duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;22338&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;44100&amp;quot; bitsPerSample=&amp;quot;16&amp;quot; nrAudioChannels=&amp;quot;2&amp;quot; microsoft:codec=&amp;quot;{00000055-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3&amp;lt;/res&amp;gt;&amp;lt;res duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;22338&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=10;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;44100&amp;quot; bitsPerSample=&amp;quot;16&amp;quot; nrAudioChannels=&amp;quot;2&amp;quot; microsoft:codec=&amp;quot;{00000055-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000008-A9AF-4584-84E2-55BFEF0A7D7E&amp;lt;/res&amp;gt;&amp;lt;res duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;176400&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/L16;rate=44100;channels=2:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;44100&amp;quot; bitsPerSample=&amp;quot;16&amp;quot; nrAudioChannels=&amp;quot;2&amp;quot; microsoft:codec=&amp;quot;{00000001-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000033-A9AF-4584-84E2-55BFEF0A7D7E&amp;lt;/res&amp;gt;&amp;lt;res duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;8000&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/x-ms-wma:DLNA.ORG_PN=WMABASE;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;44100&amp;quot; nrAudioChannels=&amp;quot;2&amp;quot; microsoft:codec=&amp;quot;{00000161-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.wma?formatID=000000BA-A9AF-4584-84E2-55BFEF0A7D7E&amp;lt;/res&amp;gt;&amp;lt;res duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;24000&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/mp4:DLNA.ORG_PN=AAC_ISO_320;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;48000&amp;quot; nrAudioChannels=&amp;quot;2&amp;quot; microsoft:codec=&amp;quot;{00001610-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.m4a?formatID=00000013-A9AF-4584-84E2-55BFEF0A7D7E&amp;lt;/res&amp;gt;&amp;lt;res duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;88200&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/L16;rate=44100;channels=1:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;44100&amp;quot; bitsPerSample=&amp;quot;16&amp;quot; nrAudioChannels=&amp;quot;1&amp;quot; microsoft:codec=&amp;quot;{00000001-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=0000002F-A9AF-4584-84E2-55BFEF0A7D7E&amp;lt;/res&amp;gt;&amp;lt;upnp:class&amp;gt;object.item.audioItem&amp;lt;/upnp:class&amp;gt;&amp;lt;upnp:genre&amp;gt;Classical&amp;lt;/upnp:genre&amp;gt;&amp;lt;upnp:artist role=&amp;quot;Performer&amp;quot;&amp;gt;Mozart&amp;lt;/upnp:artist&amp;gt;&amp;lt;upnp:album&amp;gt;Complete Works Brilliant Volume 2(CD18)&amp;lt;/upnp:album&amp;gt;&amp;lt;dc:date&amp;gt;1996-01-02&amp;lt;/dc:date&amp;gt;&amp;lt;upnp:scheduledStartTime&amp;gt;1996/01/01:00:00:00.000&amp;lt;/upnp:scheduledStartTime&amp;gt;&amp;lt;dc:description&amp;gt;https://archive.org/details/MozartCompleteWorksBrilliant170CD
https://archive.org/details/MozartCompleteWorksBrilliant170CD&amp;lt;/dc:description&amp;gt;&amp;lt;desc id=&amp;quot;artist&amp;quot; nameSpace=&amp;quot;urn:schemas-microsoft-com:WMPNSS-1-0/&amp;quot; xmlns:microsoft=&amp;quot;urn:schemas-microsoft-com:WMPNSS-1-0/&amp;quot;&amp;gt;&amp;lt;microsoft:artistPerformer&amp;gt;Mozart&amp;lt;/microsoft:artistPerformer&amp;gt;&amp;lt;/desc&amp;gt;&amp;lt;desc id=&amp;quot;Year&amp;quot; nameSpace=&amp;quot;urn:schemas-microsoft-com:WMPNSS-1-0/&amp;quot; xmlns:microsoft=&amp;quot;urn:schemas-microsoft-com:WMPNSS-1-0/&amp;quot;&amp;gt;&amp;lt;microsoft:year&amp;gt;1996&amp;lt;/microsoft:year&amp;gt;&amp;lt;/desc&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;PLAYING&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;908:03:20.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; xmlns:microsoft=&amp;quot;urn:schemas-microsoft-com:WMPNSS-1-0/&amp;quot; xmlns:dlna=&amp;quot;urn:schemas-dlna-org:metadata-1-0/&amp;quot;&amp;gt;&amp;lt;item id=&amp;quot;1000&amp;quot; restricted=&amp;quot;1&amp;quot; parentID=&amp;quot;0&amp;quot; microsoft:cpId=&amp;quot;{372B6B86-7E04-4D97-9C9A-51337A7B214B}&amp;quot; microsoft:trackId=&amp;quot;1&amp;quot;&amp;gt;&amp;lt;dc:title&amp;gt;Violin Concertos KV 364-190&amp;lt;/dc:title&amp;gt;&amp;lt;dc:creator&amp;gt;Mozart&amp;lt;/dc:creator&amp;gt;&amp;lt;res size=&amp;quot;73025024&amp;quot; duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;22338&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;44100&amp;quot; bitsPerSample=&amp;quot;16&amp;quot; nrAudioChannels=&amp;quot;2&amp;quot; microsoft:codec=&amp;quot;{00000055-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3&amp;lt;/res&amp;gt;&amp;lt;res duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;22338&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=10;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;44100&amp;quot; bitsPerSample=&amp;quot;16&amp;quot; nrAudioChannels=&amp;quot;2&amp;quot; microsoft:codec=&amp;quot;{00000055-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000008-A9AF-4584-84E2-55BFEF0A7D7E&amp;lt;/res&amp;gt;&amp;lt;res duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;176400&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/L16;rate=44100;channels=2:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;44100&amp;quot; bitsPerSample=&amp;quot;16&amp;quot; nrAudioChannels=&amp;quot;2&amp;quot; microsoft:codec=&amp;quot;{00000001-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000033-A9AF-4584-84E2-55BFEF0A7D7E&amp;lt;/res&amp;gt;&amp;lt;res duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;8000&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/x-ms-wma:DLNA.ORG_PN=WMABASE;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;44100&amp;quot; nrAudioChannels=&amp;quot;2&amp;quot; microsoft:codec=&amp;quot;{00000161-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.wma?formatID=000000BA-A9AF-4584-84E2-55BFEF0A7D7E&amp;lt;/res&amp;gt;&amp;lt;res duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;24000&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/mp4:DLNA.ORG_PN=AAC_ISO_320;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;48000&amp;quot; nrAudioChannels=&amp;quot;2&amp;quot; microsoft:codec=&amp;quot;{00001610-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.m4a?formatID=00000013-A9AF-4584-84E2-55BFEF0A7D7E&amp;lt;/res&amp;gt;&amp;lt;res duration=&amp;quot;0:54:29.015&amp;quot; bitrate=&amp;quot;88200&amp;quot; protocolInfo=&amp;quot;http-get:*:audio/L16;rate=44100;channels=1:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&amp;quot; sampleFrequency=&amp;quot;44100&amp;quot; bitsPerSample=&amp;quot;16&amp;quot; nrAudioChannels=&amp;quot;1&amp;quot; microsoft:codec=&amp;quot;{00000001-0000-0010-8000-00AA00389B71}&amp;quot;&amp;gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=0000002F-A9AF-4584-84E2-55BFEF0A7D7E&amp;lt;/res&amp;gt;&amp;lt;upnp:class&amp;gt;object.item.audioItem&amp;lt;/upnp:class&amp;gt;&amp;lt;upnp:genre&amp;gt;Classical&amp;lt;/upnp:genre&amp;gt;&amp;lt;upnp:artist role=&amp;quot;Performer&amp;quot;&amp;gt;Mozart&amp;lt;/upnp:artist&amp;gt;&amp;lt;upnp:album&amp;gt;Complete Works Brilliant Volume 2(CD18)&amp;lt;/upnp:album&amp;gt;&amp;lt;dc:date&amp;gt;1996-01-02&amp;lt;/dc:date&amp;gt;&amp;lt;upnp:scheduledStartTime&amp;gt;1996/01/01:00:00:00.000&amp;lt;/upnp:scheduledStartTime&amp;gt;&amp;lt;dc:description&amp;gt;https://archive.org/details/MozartCompleteWorksBrilliant170CD
https://archive.org/details/MozartCompleteWorksBrilliant170CD&amp;lt;/dc:description&amp;gt;&amp;lt;desc id=&amp;quot;artist&amp;quot; nameSpace=&amp;quot;urn:schemas-microsoft-com:WMPNSS-1-0/&amp;quot; xmlns:microsoft=&amp;quot;urn:schemas-microsoft-com:WMPNSS-1-0/&amp;quot;&amp;gt;&amp;lt;microsoft:artistPerformer&amp;gt;Mozart&amp;lt;/microsoft:artistPerformer&amp;gt;&amp;lt;/desc&amp;gt;&amp;lt;desc id=&amp;quot;Year&amp;quot; nameSpace=&amp;quot;urn:schemas-microsoft-com:WMPNSS-1-0/&amp;quot; xmlns:microsoft=&amp;quot;urn:schemas-microsoft-com:WMPNSS-1-0/&amp;quot;&amp;gt;&amp;lt;microsoft:year&amp;gt;1996&amp;lt;/microsoft:year&amp;gt;&amp;lt;/desc&amp;gt;&amp;lt;/item&amp;gt;&amp;lt;/DIDL-Lite&amp;gt;&quot;/&gt;&lt;CurrentTrackURI val=&quot;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3&quot;/&gt;&lt;CurrentMediaDuration val=&quot;908:03:20.000&quot;/&gt;&lt;CurrentTransportActions val=&quot;Play,Pause,Stop&quot;/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.03.21 12:18:03 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.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.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; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:dlna=&quot;urn:schemas-dlna-org:metadata-1-0/&quot;&gt;&lt;item id=&quot;1000&quot; restricted=&quot;1&quot; parentID=&quot;0&quot; microsoft:cpId=&quot;{372B6B86-7E04-4D97-9C9A-51337A7B214B}&quot; microsoft:trackId=&quot;1&quot;&gt;&lt;dc:title&gt;Violin Concertos KV 364-190&lt;/dc:title&gt;&lt;dc:creator&gt;Mozart&lt;/dc:creator&gt;&lt;res size=&quot;73025024&quot; duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=10;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000008-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;176400&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=2:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000033-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;8000&quot; protocolInfo=&quot;http-get:*:audio/x-ms-wma:DLNA.ORG_PN=WMABASE;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000161-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.wma?formatID=000000BA-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;24000&quot; protocolInfo=&quot;http-get:*:audio/mp4:DLNA.ORG_PN=AAC_ISO_320;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;48000&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00001610-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.m4a?formatID=00000013-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;88200&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=1:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;1&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=0000002F-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;upnp:class&gt;object.item.audioItem&lt;/upnp:class&gt;&lt;upnp:genre&gt;Classical&lt;/upnp:genre&gt;&lt;upnp:artist role=&quot;Performer&quot;&gt;Mozart&lt;/upnp:artist&gt;&lt;upnp:album&gt;Complete Works Brilliant Volume 2(CD18)&lt;/upnp:album&gt;&lt;dc:date&gt;1996-01-02&lt;/dc:date&gt;&lt;upnp:scheduledStartTime&gt;1996/01/01:00:00:00.000&lt;/upnp:scheduledStartTime&gt;&lt;dc:description&gt;https://archive.org/details/MozartCompleteWorksBrilliant170CD
https://archive.org/details/MozartCompleteWorksBrilliant170CD&lt;/dc:description&gt;&lt;desc id=&quot;artist&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:artistPerformer&gt;Mozart&lt;/microsoft:artistPerformer&gt;&lt;/desc&gt;&lt;desc id=&quot;Year&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:year&gt;1996&lt;/microsoft:year&gt;&lt;/desc&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="PLAYING"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="1"/><CurrentTrackDuration val="908:03:20.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; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:dlna=&quot;urn:schemas-dlna-org:metadata-1-0/&quot;&gt;&lt;item id=&quot;1000&quot; restricted=&quot;1&quot; parentID=&quot;0&quot; microsoft:cpId=&quot;{372B6B86-7E04-4D97-9C9A-51337A7B214B}&quot; microsoft:trackId=&quot;1&quot;&gt;&lt;dc:title&gt;Violin Concertos KV 364-190&lt;/dc:title&gt;&lt;dc:creator&gt;Mozart&lt;/dc:creator&gt;&lt;res size=&quot;73025024&quot; duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=10;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000008-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;176400&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=2:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000033-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;8000&quot; protocolInfo=&quot;http-get:*:audio/x-ms-wma:DLNA.ORG_PN=WMABASE;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000161-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.wma?formatID=000000BA-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;24000&quot; protocolInfo=&quot;http-get:*:audio/mp4:DLNA.ORG_PN=AAC_ISO_320;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;48000&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00001610-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.m4a?formatID=00000013-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;88200&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=1:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;1&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=0000002F-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;upnp:class&gt;object.item.audioItem&lt;/upnp:class&gt;&lt;upnp:genre&gt;Classical&lt;/upnp:genre&gt;&lt;upnp:artist role=&quot;Performer&quot;&gt;Mozart&lt;/upnp:artist&gt;&lt;upnp:album&gt;Complete Works Brilliant Volume 2(CD18)&lt;/upnp:album&gt;&lt;dc:date&gt;1996-01-02&lt;/dc:date&gt;&lt;upnp:scheduledStartTime&gt;1996/01/01:00:00:00.000&lt;/upnp:scheduledStartTime&gt;&lt;dc:description&gt;https://archive.org/details/MozartCompleteWorksBrilliant170CD
https://archive.org/details/MozartCompleteWorksBrilliant170CD&lt;/dc:description&gt;&lt;desc id=&quot;artist&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:artistPerformer&gt;Mozart&lt;/microsoft:artistPerformer&gt;&lt;/desc&gt;&lt;desc id=&quot;Year&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:year&gt;1996&lt;/microsoft:year&gt;&lt;/desc&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3"/><CurrentMediaDuration val="908:03:20.000"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
2021.03.21 12:18:03 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.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.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; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:dlna=&quot;urn:schemas-dlna-org:metadata-1-0/&quot;&gt;&lt;item id=&quot;1000&quot; restricted=&quot;1&quot; parentID=&quot;0&quot; microsoft:cpId=&quot;{372B6B86-7E04-4D97-9C9A-51337A7B214B}&quot; microsoft:trackId=&quot;1&quot;&gt;&lt;dc:title&gt;Violin Concertos KV 364-190&lt;/dc:title&gt;&lt;dc:creator&gt;Mozart&lt;/dc:creator&gt;&lt;res size=&quot;73025024&quot; duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=10;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000008-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;176400&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=2:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000033-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;8000&quot; protocolInfo=&quot;http-get:*:audio/x-ms-wma:DLNA.ORG_PN=WMABASE;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000161-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.wma?formatID=000000BA-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;24000&quot; protocolInfo=&quot;http-get:*:audio/mp4:DLNA.ORG_PN=AAC_ISO_320;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;48000&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00001610-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.m4a?formatID=00000013-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;88200&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=1:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;1&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=0000002F-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;upnp:class&gt;object.item.audioItem&lt;/upnp:class&gt;&lt;upnp:genre&gt;Classical&lt;/upnp:genre&gt;&lt;upnp:artist role=&quot;Performer&quot;&gt;Mozart&lt;/upnp:artist&gt;&lt;upnp:album&gt;Complete Works Brilliant Volume 2(CD18)&lt;/upnp:album&gt;&lt;dc:date&gt;1996-01-02&lt;/dc:date&gt;&lt;upnp:scheduledStartTime&gt;1996/01/01:00:00:00.000&lt;/upnp:scheduledStartTime&gt;&lt;dc:description&gt;https://archive.org/details/MozartCompleteWorksBrilliant170CD\nhttps://archive.org/details/MozartCompleteWorksBrilliant170CD&lt;/dc:description&gt;&lt;desc id=&quot;artist&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:artistPerformer&gt;Mozart&lt;/microsoft:artistPerformer&gt;&lt;/desc&gt;&lt;desc id=&quot;Year&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:year&gt;1996&lt;/microsoft:year&gt;&lt;/desc&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="PLAYING"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="1"/><CurrentTrackDuration val="908:03:20.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; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:dlna=&quot;urn:schemas-dlna-org:metadata-1-0/&quot;&gt;&lt;item id=&quot;1000&quot; restricted=&quot;1&quot; parentID=&quot;0&quot; microsoft:cpId=&quot;{372B6B86-7E04-4D97-9C9A-51337A7B214B}&quot; microsoft:trackId=&quot;1&quot;&gt;&lt;dc:title&gt;Violin Concertos KV 364-190&lt;/dc:title&gt;&lt;dc:creator&gt;Mozart&lt;/dc:creator&gt;&lt;res size=&quot;73025024&quot; duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=10;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000008-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;176400&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=2:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000033-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;8000&quot; protocolInfo=&quot;http-get:*:audio/x-ms-wma:DLNA.ORG_PN=WMABASE;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000161-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.wma?formatID=000000BA-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;24000&quot; protocolInfo=&quot;http-get:*:audio/mp4:DLNA.ORG_PN=AAC_ISO_320;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;48000&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00001610-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.m4a?formatID=00000013-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;88200&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=1:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;1&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=0000002F-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;upnp:class&gt;object.item.audioItem&lt;/upnp:class&gt;&lt;upnp:genre&gt;Classical&lt;/upnp:genre&gt;&lt;upnp:artist role=&quot;Performer&quot;&gt;Mozart&lt;/upnp:artist&gt;&lt;upnp:album&gt;Complete Works Brilliant Volume 2(CD18)&lt;/upnp:album&gt;&lt;dc:date&gt;1996-01-02&lt;/dc:date&gt;&lt;upnp:scheduledStartTime&gt;1996/01/01:00:00:00.000&lt;/upnp:scheduledStartTime&gt;&lt;dc:description&gt;https://archive.org/details/MozartCompleteWorksBrilliant170CD\nhttps://archive.org/details/MozartCompleteWorksBrilliant170CD&lt;/dc:description&gt;&lt;desc id=&quot;artist&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:artistPerformer&gt;Mozart&lt;/microsoft:artistPerformer&gt;&lt;/desc&gt;&lt;desc id=&quot;Year&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:year&gt;1996&lt;/microsoft:year&gt;&lt;/desc&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3"/><CurrentMediaDuration val="908:03:20.000"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>


Bei folgendem Eintrag crashed der Forum-Editor. Er ist unvollständig und ich kann dahinter nichts mehr schreiben, sonst crashed es beim Speichern.

2021.03.21 12:18:03 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.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.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; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:dlna=&quot;urn:schemas-dlna-org:metadata-1-0/&quot;&gt;&lt;item id=&quot;1000&quot; restricted=&quot;1&quot; parentID=&quot;0&quot; microsoft:cpId=&quot;{372B6B86-7E04-4D97-9C9A-51337A7B214B}&quot; microsoft:trackId=&quot;1&quot;&gt;&lt;dc:title&gt;Violin Concertos KV 364-190&lt;/dc:title&gt;&lt;dc:creator&gt;Mozart&lt;/dc:creator&gt;&lt;res size=&quot;73025024&quot; duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=10;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000008-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;176400&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=2:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000033-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;8000&

[RockFan]

Ich versuche es mal weiter:

Code Auswählen Erweitern


2021.03.21 12:18:03 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.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.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; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:dlna=&quot;urn:schemas-dlna-org:metadata-1-0/&quot;&gt;&lt;item id=&quot;1000&quot; restricted=&quot;1&quot; parentID=&quot;0&quot; microsoft:cpId=&quot;{372B6B86-7E04-4D97-9C9A-51337A7B214B}&quot; microsoft:trackId=&quot;1&quot;&gt;&lt;dc:title&gt;Violin Concertos KV 364-190&lt;/dc:title&gt;&lt;dc:creator&gt;Mozart&lt;/dc:creator&gt;&lt;res size=&quot;73025024&quot; duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=10;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000008-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;176400&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=2:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000033-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;8000&quot; protocolInfo=&quot;http-get:*:audio/x-ms-wma:DLNA.ORG_PN=WMABASE;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000161-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.wma?formatID=000000BA-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;24000&quot; protocolInfo=&quot;http-get:*:audio/mp4:DLNA.ORG_PN=AAC_ISO_320;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;48000&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00001610-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.m4a?formatID=00000013-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;88200&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=1:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;1&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=0000002F-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;upnp:class&gt;object.item.audioItem&lt;/upnp:class&gt;&lt;upnp:genre&gt;Classical&lt;/upnp:genre&gt;&lt;upnp:artist role=&quot;Performer&quot;&gt;Mozart&lt;/upnp:artist&gt;&lt;upnp:album&gt;Complete Works Brilliant Volume 2(CD18)&lt;/upnp:album&gt;&lt;dc:date&gt;1996-01-02&lt;/dc:date&gt;&lt;upnp:scheduledStartTime&gt;1996/01/01:00:00:00.000&lt;/upnp:scheduledStartTime&gt;&lt;dc:description&gt;https://archive.org/details/MozartCompleteWorksBrilliant170CD
https://archive.org/details/MozartCompleteWorksBrilliant170CD&lt;/dc:description&gt;&lt;desc id=&quot;artist&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:artistPerformer&gt;Mozart&lt;/microsoft:artistPerformer&gt;&lt;/desc&gt;&lt;desc id=&quot;Year&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:year&gt;1996&lt;/microsoft:year&gt;&lt;/desc&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="PLAYING"/><TransportStatus val="OK"/><TransportPlaySpeed val="1"/><CurrentTrack val="1"/><CurrentTrackDuration val="908:03:20.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; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:dlna=&quot;urn:schemas-dlna-org:metadata-1-0/&quot;&gt;&lt;item id=&quot;1000&quot; restricted=&quot;1&quot; parentID=&quot;0&quot; microsoft:cpId=&quot;{372B6B86-7E04-4D97-9C9A-51337A7B214B}&quot; microsoft:trackId=&quot;1&quot;&gt;&lt;dc:title&gt;Violin Concertos KV 364-190&lt;/dc:title&gt;&lt;dc:creator&gt;Mozart&lt;/dc:creator&gt;&lt;res size=&quot;73025024&quot; duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;22338&quot; protocolInfo=&quot;http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=10;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000055-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000008-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;176400&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=2:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=00000033-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;8000&quot; protocolInfo=&quot;http-get:*:audio/x-ms-wma:DLNA.ORG_PN=WMABASE;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00000161-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.wma?formatID=000000BA-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;24000&quot; protocolInfo=&quot;http-get:*:audio/mp4:DLNA.ORG_PN=AAC_ISO_320;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;48000&quot; nrAudioChannels=&quot;2&quot; microsoft:codec=&quot;{00001610-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.m4a?formatID=00000013-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;res duration=&quot;0:54:29.015&quot; bitrate=&quot;88200&quot; protocolInfo=&quot;http-get:*:audio/L16;rate=44100;channels=1:DLNA.ORG_PN=LPCM;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01700000000000000000000000000000&quot; sampleFrequency=&quot;44100&quot; bitsPerSample=&quot;16&quot; nrAudioChannels=&quot;1&quot; microsoft:codec=&quot;{00000001-0000-0010-8000-00AA00389B71}&quot;&gt;http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3?formatID=0000002F-A9AF-4584-84E2-55BFEF0A7D7E&lt;/res&gt;&lt;upnp:class&gt;object.item.audioItem&lt;/upnp:class&gt;&lt;upnp:genre&gt;Classical&lt;/upnp:genre&gt;&lt;upnp:artist role=&quot;Performer&quot;&gt;Mozart&lt;/upnp:artist&gt;&lt;upnp:album&gt;Complete Works Brilliant Volume 2(CD18)&lt;/upnp:album&gt;&lt;dc:date&gt;1996-01-02&lt;/dc:date&gt;&lt;upnp:scheduledStartTime&gt;1996/01/01:00:00:00.000&lt;/upnp:scheduledStartTime&gt;&lt;dc:description&gt;https://archive.org/details/MozartCompleteWorksBrilliant170CD
https://archive.org/details/MozartCompleteWorksBrilliant170CD&lt;/dc:description&gt;&lt;desc id=&quot;artist&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:artistPerformer&gt;Mozart&lt;/microsoft:artistPerformer&gt;&lt;/desc&gt;&lt;desc id=&quot;Year&quot; nameSpace=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot; xmlns:microsoft=&quot;urn:schemas-microsoft-com:WMPNSS-1-0/&quot;&gt;&lt;microsoft:year&gt;1996&lt;/microsoft:year&gt;&lt;/desc&gt;&lt;/item&gt;&lt;/DIDL-Lite&gt;"/><CurrentTrackURI val="http://192.168.178.38:10246/MDEServer/D0A85666-3A6A-44F3-84C7-495F4C13063E/1000.mp3"/><CurrentMediaDuration val="908:03:20.000"/><CurrentTransportActions val="Play,Pause,Stop"/></InstanceID></Event>
2021.03.21 12:18:03 3: UPNPController: handleOnce failed, Not a HASH reference at ./FHEM/98_DLNAController.pm line 891.

2021.03.21 12:18:03 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback , Not a HASH reference at ./FHEM/98_DLNAController.pm line 891.

2021.03.21 12:18:13 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 12:18:20 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.03.21 12:18:20 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.03.21 12:18:20 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.21 12:18:34 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.21 12:18:34 5: UPNPController: Received event: by 192.168.178.61_2870-zs-AVTransport UPnP::ControlPoint::Service=HASH(0xb382a00) $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.03.21 12:18:34 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.03.21 12:18:34 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.03.21 12:18:34 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.03.21 12:18:34 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>
2021.03.21 12:18:34 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,
2021.03.21 12:19:10 5: UPNPController: incoming message; will be processed by perlupnp handleOnce
2021.03.21 12:19:10 5: UPNPController: Received event: by 192.168.178.38_2869-zs-RenderingControl UPnP::ControlPoint::Service=HASH(0x9e87860) $VAR1 = 'LastChange';
$VAR2 = '&lt;Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"&gt;&lt;InstanceID val="0"&gt;&lt;Mute channel="Master" val="1"/&gt;&lt;/InstanceID&gt;&lt;/Event&gt;';

2021.03.21 12:19:10 5: UPNPController: Received event: by 192.168.178.38_2869-zs-RenderingControl property: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="1"/></InstanceID></Event>
2021.03.21 12:19:10 5: UPNP_Controller: dispatch RenderingControl|192.168.178.38_2869|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="1"/></InstanceID></Event>
2021.03.21 12:19:10 5: DLNAController: message from UPNP_Controller, message: RenderingControl|192.168.178.38_2869|LastChange|<Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="1"/></InstanceID></Event>
2021.03.21 12:19:10 4: DLNAController: message parameters: RenderingControl, 192.168.178.38_2869, LastChange, <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/"><InstanceID val="0"><Mute channel="Master" val="1"/></InstanceID></Event>
2021.03.21 12:19:10 5: UPNPController: UPNPSocket-UPNP_Controller-44169, received subscription event: event was processed by subscriptionCallback ,
2021.03.21 12:19:10 4: UPNPController: discovery message of Familie (MEDIACENTERPC : Windows Media Player) with UDN: uuid:f69b1dc1-94aa-49d1-be51-fedbc77b0b9c action: deviceRemoved
2021.03.21 12:19:10 5: UPNPController: UPNP_Controller: byebye-notify message device 192.168.178.38_2869 received
2021.03.21 12:19:10 5: UPNPController: earlier subscribed service RenderingControl of device 192.168.178.38_2869 went offline
2021.03.21 12:19:10 5: UPNP_Controller: dispatch RenderingControl|192.168.178.38_2869|offline|urn:schemas-upnp-org:metadata-1-0/RCS
2021.03.21 12:19:10 5: DLNAController: message from UPNP_Controller, message: RenderingControl|192.168.178.38_2869|offline|urn:schemas-upnp-org:metadata-1-0/RCS
2021.03.21 12:19:10 4: DLNAController: message parameters: RenderingControl, 192.168.178.38_2869, offline, urn:schemas-upnp-org:metadata-1-0/RCS
2021.03.21 12:19:13 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 12:19:13 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.105_2869

2021.03.21 12:20:13 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 12:20:20 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.03.21 12:20:20 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.03.21 12:20:20 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

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

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

2021.03.21 12:20:50 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.21 12:21:13 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800

2021.03.21 12:22:13 4: UPNPController: try to renew subscriptions for services, device UPNP_Controller with timeout: 1800
2021.03.21 12:22:13 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.58_8080
2021.03.21 12:22:13 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:22:13 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.21 12:22:13 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.58_8080
2021.03.21 12:22:13 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 412 Precondition Failed at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:22:13 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.58_8080 failed: , try to subscribe
2021.03.21 12:22:13 5: UPNPController: renew subscription for service AVTransport of device 192.168.178.61_2870
2021.03.21 12:22:18 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 500 Can't connect to 192.168.178.61:2870 (Connection timed out) at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:22:18 4: UPNPController: renewal of subscription for service AVTransport of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.21 12:22:18 5: UPNPController: renew subscription for service RenderingControl of device 192.168.178.61_2870
2021.03.21 12:22:20 5: UPNPController: warning: main, Use of uninitialized value $filemtime in concatenation (.) or string at ./FHEM/70_WINCONNECT.pm line 252.

2021.03.21 12:22:20 5: UPNPController: warning: main, Use of uninitialized value $filemtime in string eq at ./FHEM/70_WINCONNECT.pm line 281.

2021.03.21 12:22:20 5: UPNPController: warning: main, Use of uninitialized value $value in string eq at fhem.pl line 4865.

2021.03.21 12:22:23 5: UPNPController: warning: Carp, Renewal of subscription failed with error: 500 Can't connect to 192.168.178.61:2870 (Connection timed out) at ./FHEM/98_UPNPController.pm line 786.

2021.03.21 12:22:23 4: UPNPController: renewal of subscription for service RenderingControl of device 192.168.178.61_2870 failed: , try to subscribe
2021.03.21 12:22:23 5: UPNPController: renewSubscriptionsfinished name UPNP_Controller, readingname 192.168.178.61_2870-zs-RenderingControl
2021.03.21 12:22:23 4: UPNPController: subscribe: reading  192.168.178.61_2870-zs-RenderingControl, uniquedevice 192.168.178.61_2870, service RenderingControl
2021.03.21 12:22:23 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.21 12:22:23 5: UPNPController: RenderingControl: urn:schemas-upnp-org:service:RenderingControl:1 found. OK.
2021.03.21 12:22:26 5: UPNPController: warning: Carp, Subscription request failed with error: 500 Can't connect to 192.168.178.61:2870 (No route to host) at ./FHEM/98_UPNPController.pm line 716.

2021.03.21 12:22:26 4: UPNPController: UPNP_Controller: uniqueDeviceName 192.168.178.61_2870 event offline not yet implemented
2021.03.21 12:22:26 3: UPNPController: subscription for service RenderingControl of device 192.168.178.61_2870 failed:


[KölnSolar]

Hi Dieter,

Im Mediaplayer war davon aber nichts zu sehen.

Dachte ich mir. Dann haben auch wir kaum eine Chance.

TV sieht ganz gut aus.

Hast Du die aktuelle Version 13.3. laufen ?

Ich könnt mir vorstellen, dass das Medion uns Kopfschmerzen bereitet. Kannst Du es bitte per ignordIPs ausschließen und den TV testen. Erstmal nur verbose=4 und DLNAController-device benutzen/beobachten.

Grüße Markus

[RockFan]

Hallo Markus,

Hast Du die aktuelle Version 13.3. laufen ?

Ja, beide Controller-Versionen vom 13.März.

Ich könnt mir vorstellen, dass das Medion uns Kopfschmerzen bereitet.

TV und Radio sind von Medion . Ich denke du meinst "Medion-Radio".

Kannst Du es bitte per ignordIPs ausschließen und den TV testen. Erstmal nur verbose=4 und DLNAController-device benutzen/beobachten.

Verstehe ich es richtig: Die Radio-IP in ignoredIPs eintragen?
Die Testergebnisse für das TV-Gerät im Eröffnungs-Post dieses Threads hatte ich eigentlich bereits mit den aktuellen Versionen gemacht. Da tat sich im DLNAController nicht viel. Nur online/offline "bewegte" sich in bestimmten Situationen. Steuern konnte ich vom DLNAController gar nichts. Ist durch das Ignorieren der Radio-IP eine Änderung zu erwarten? Oder meinst Du andere Tests?

Viele Grüße
Dieter