Sonos Play1 soll TV-Sound abspielen und ggf Rückmeldung

Begonnen von aherby, 07 November 2014, 22:14:51

Vorheriges Thema - Nächstes Thema

rapster


Nachdem ich mal eine Aktion (MuteT) angeklickt habe:

> fhem.log bleibt leer (verbose 3)

stdout:
2014.11.17 20:29:44 3: SONOS1: UPnP-Thread gestartet.
Odd number of elements in hash assignment at FHEM/lib/UPnP/ControlPoint.pm line 30, <$client> line 7.
2014.11.17 20:29:44 1: SONOS2: Restore-Thread gestartet. Warte auf Arbeit...
2014.11.17 20:29:44 3: SONOS1: ProxyObject does not exists
2014.11.17 20:29:44 2: SONOS1: Discover Sonosplayer 'Bad' (S1) Software Revision 5.2 with ID 'RINCON_000E58C74E4801400_MR'
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
2014.11.17 20:29:44 2: SONOS1: SonosPlayer 'Bad' (S1) Software Revision 5.2 with ID 'RINCON_000E58C74E4801400_MR' is already defined and will only be updated
2014.11.17 20:29:44 2: SONOS1: SonosPlayer 'Bad' is now updated
2014.11.17 20:29:44 2: SONOS1: Service-subscribing successful with SID="uuid:RINCON_000E58C74E4801400_sub0000000539" and Timeout="86400s"
2014.11.17 20:29:44 2: SONOS1: Rendering-Service-subscribing successful with SID="uuid:RINCON_000E58C74E4801400_sub0000000540" and Timeout="86400s"
2014.11.17 20:29:44 2: SONOS1: Alarm-Service-subscribing successful with SID="uuid:RINCON_000E58C74E4801400_sub0000000541" and Timeout="86400s"
2014.11.17 20:29:44 2: SONOS1: ZoneGroupTopology-Service-subscribing successful with SID="uuid:RINCON_000E58C74E4801400_sub0000000542" and Timeout="86400s"
2014.11.17 20:29:44 2: SONOS1: DeviceProperties-Service-subscribing successful with SID="uuid:RINCON_000E58C74E4801400_sub0000000543" and Timeout="86400s"
2014.11.17 20:29:44 3: SONOS1: Discover: End of discover-event for "Bad".
2014.11.17 20:29:44 2: SONOS1: Discover Sonosplayer 'Kueche' (S9) Software Revision 5.2 with ID 'RINCON_000E58B7AF1401400_MR'
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
2014.11.17 20:29:45 2: SONOS1: SonosPlayer 'Kueche' (S9) Software Revision 5.2 with ID 'RINCON_000E58B7AF1401400_MR' is already defined and will only be updated
2014.11.17 20:29:45 2: SONOS1: SonosPlayer 'Kueche' is now updated
2014.11.17 20:29:45 2: SONOS1: Service-subscribing successful with SID="uuid:RINCON_000E58B7AF1401400_sub0000000480" and Timeout="86400s"
2014.11.17 20:29:45 2: SONOS1: Rendering-Service-subscribing successful with SID="uuid:RINCON_000E58B7AF1401400_sub0000000481" and Timeout="86400s"
2014.11.17 20:29:45 2: SONOS1: Alarm-Service-subscribing successful with SID="uuid:RINCON_000E58B7AF1401400_sub0000000482" and Timeout="86400s"
2014.11.17 20:29:45 2: SONOS1: ZoneGroupTopology-Service-subscribing successful with SID="uuid:RINCON_000E58B7AF1401400_sub0000000483" and Timeout="86400s"
2014.11.17 20:29:45 2: SONOS1: DeviceProperties-Service-subscribing successful with SID="uuid:RINCON_000E58B7AF1401400_sub0000000484" and Timeout="86400s"
2014.11.17 20:29:45 3: SONOS1: Discover: End of discover-event for "Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: Received Transport-Event for Zone "Sonos_Bad".
2014.11.17 20:29:45 3: SONOS1: Event: End of Transport-Event for Zone "Sonos_Bad".
2014.11.17 20:29:45 2: SONOS1: Discover Sonosplayer 'Schlafzimmer' (S1) Software Revision 5.2 with ID 'RINCON_B8E93752FD2401400_MR'
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
2014.11.17 20:29:45 2: SONOS1: SonosPlayer 'Schlafzimmer' (S1) Software Revision 5.2 with ID 'RINCON_B8E93752FD2401400_MR' is already defined and will only be updated
2014.11.17 20:29:45 2: SONOS1: SonosPlayer 'Schlafzimmer' is now updated
2014.11.17 20:29:45 2: SONOS1: Service-subscribing successful with SID="uuid:RINCON_B8E93752FD2401400_sub0000000480" and Timeout="86400s"
2014.11.17 20:29:45 2: SONOS1: Rendering-Service-subscribing successful with SID="uuid:RINCON_B8E93752FD2401400_sub0000000481" and Timeout="86400s"
2014.11.17 20:29:45 2: SONOS1: Alarm-Service-subscribing successful with SID="uuid:RINCON_B8E93752FD2401400_sub0000000482" and Timeout="86400s"
2014.11.17 20:29:45 2: SONOS1: ZoneGroupTopology-Service-subscribing successful with SID="uuid:RINCON_B8E93752FD2401400_sub0000000483" and Timeout="86400s"
2014.11.17 20:29:45 2: SONOS1: DeviceProperties-Service-subscribing successful with SID="uuid:RINCON_B8E93752FD2401400_sub0000000484" and Timeout="86400s"
2014.11.17 20:29:45 3: SONOS1: Discover: End of discover-event for "Schlafzimmer".
2014.11.17 20:29:45 3: SONOS1: Event: Received Transport-Event for Zone "Sonos_Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: End of Transport-Event for Zone "Sonos_Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: Received Alarm-Event for Zone "Sonos_Bad".
2014.11.17 20:29:45 3: SONOS1: Event: End of Alarm-Event for Zone "Sonos_Bad".
2014.11.17 20:29:45 3: SONOS1: Event: Received Transport-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 20:29:45 3: SONOS1: Event: End of Transport-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 20:29:45 3: SONOS1: Event: Received Alarm-Event for Zone "Sonos_Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: End of Alarm-Event for Zone "Sonos_Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Bad".
2014.11.17 20:29:45 3: SONOS1: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Bad".
2014.11.17 20:29:45 3: SONOS1: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: Received DeviceProperties-Event for Zone "Sonos_Bad".
2014.11.17 20:29:45 3: SONOS1: Event: End of DeviceProperties-Event for Zone "Sonos_Bad".
2014.11.17 20:29:45 3: SONOS1: Event: Received DeviceProperties-Event for Zone "Sonos_Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: End of DeviceProperties-Event for Zone "Sonos_Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: Received Rendering-Event for Zone "Sonos_Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: End of Rendering-Event for Zone "Sonos_Kueche".
2014.11.17 20:29:45 3: SONOS1: Event: Received Rendering-Event for Zone "Sonos_Bad".
2014.11.17 20:29:45 3: SONOS1: Event: End of Rendering-Event for Zone "Sonos_Bad".
2014.11.17 20:29:45 3: SONOS1: Event: Received Alarm-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 20:29:45 3: SONOS1: Event: End of Alarm-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 20:29:45 3: SONOS1: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 20:29:45 3: SONOS1: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 20:29:45 3: SONOS1: Event: Received DeviceProperties-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 20:29:45 3: SONOS1: Event: End of DeviceProperties-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 20:29:45 3: SONOS1: Event: Received Rendering-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 20:29:45 3: SONOS1: Event: End of Rendering-Event for Zone "Sonos_Schlafzimmer".


Scheint so als ob der UPnP-Thread erst nach der ersten Aktion gestartet wird, das war gestern noch definitiv anders  :-\

Gruß

Reinerlein

Hi Claudiu,

das ist auch definitiv nicht normal... Kannst du den ersten Schritt (also wo er nicht fertig macht) mit Loglevel 5 posten (oder auch per PN)...
Da erkennt man vielleicht, was er genau erwartet oder ähnliches. Er scheint ja zumindest keine Fehlermeldung zu geben...

Grüße
Reinerlein

rapster

Hi Reinerlein,

hier mal die logs, Fhem verbose 3, Sonos verbose 5

Soll ich fhem auch auf verbose 5 setzen?

fhem.log:
2014.11.17 22:17:16.603 1: Including fhem.cfg
2014.11.17 22:17:16.648 2: eventTypes: loaded 5750 events from ./log/eventTypes.txt
2014.11.17 22:17:16.649 1: Including ./FHEM/connectionConfig.cfg
2014.11.17 22:17:16.653 3: telnetPort: port 23 opened
2014.11.17 22:17:16.688 3: WEB: port 443 opened
2014.11.17 22:17:16.726 3: WEBphone: port 8084 opened
2014.11.17 22:17:16.727 3: WEBtablet: port 8085 opened
2014.11.17 22:17:16.729 1: Including ./FHEM/CUL_VCCU.cfg
2014.11.17 22:17:16.738 3: Opening CUL1 device /dev/ttyACM0
2014.11.17 22:17:17.741 3: Setting CUL1 baudrate to 9600
2014.11.17 22:17:17.742 3: CUL1 device opened
2014.11.17 22:17:17.863 3: CUL1: Possible commands: BbCFiAZEGMKUYRTVWXefmltux
2014.11.17 22:17:17.914 2: Switched CUL1 rfmode to HomeMatic
2014.11.17 22:17:18.017 1: Including ./FHEM/actionDetector.cfg
2014.11.17 22:17:18.017 1: Including ./FHEM/HMinfo.cfg
2014.11.17 22:17:18.036 1: Including ./FHEM/devices.cfg
2014.11.17 22:17:18.100 1: Including ./FHEM/svgPlots.cfg
2014.11.17 22:17:18.115 1: Including ./FHEM/residents.cfg
2014.11.17 22:17:18.132 1: Including ./FHEM/geofancy.cfg
2014.11.17 22:17:18.136 3: Registering GEOFANCY geofancy for URL /geo...
2014.11.17 22:17:18.139 1: Including ./FHEM/dashboard.cfg
2014.11.17 22:17:18.148 1: Including ./FHEM/ignoreDevices.cfg
2014.11.17 22:17:18.150 1: Including ./FHEM/sonos.cfg
2014.11.17 22:17:18.330 1: SONOS0: Kein UPnP-Server gefunden... Starte selber einen und warte 8 sekunden darauf...
2014.11.17 22:17:26.331 3: Opening Sonos device localhost:4711
2014.11.17 22:17:26.332 3: Sonos device opened
2014.11.17 22:17:26.347 1: Including ./FHEM/pushover.cfg
2014.11.17 22:17:26.350 1: Including ./FHEM/notify.cfg
2014.11.17 22:17:26.350 1: Including ./FHEM/TEST.cfg
2014.11.17 22:17:26.367 1: Including ./log/fhem.save
2014.11.17 22:17:26.443 1: statefile: Reading Sonos_Bad->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem.
Reading Sonos_Kueche->LastActionResult must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem.
Reading Sonos_Kueche->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem.
Reading Sonos_Schlafzimmer->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem.
2014.11.17 22:17:26.448 2: Error messages while initializing FHEM: statefile: Reading Sonos_Bad->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem. Reading Sonos_Kueche->LastActionResult must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem. Reading Sonos_Kueche->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem. Reading Sonos_Schlafzimmer->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem.
2014.11.17 22:17:26.448 0: Server started with 178 defined entities (version $Id: fhem.pl 6913 2014-11-08 10:32:44Z rudolfkoenig $, os linux, user root, pid 2243)
2014.11.17 22:17:26.449 5: SONOS0: Received from UPnP-Server: ''This is UPnP-Server calling''
2014.11.17 22:17:26.449 5: SONOS0: MainTrigger()-Line: 'This is UPnP-Server calling'
2014.11.17 22:17:27.334 5: SW: 536574446174613a536f6e6f733a353a6e6f6e653a536f6e6f735f4261642c536f6e6f735f4b75656368652c536f6e6f735f5363686c61667a696d6d65723a52494e434f4e5f30303045353843373445343830313430305f4d522c52494e434f4e5f30303045353842374146313430313430305f4d522c52494e434f4e5f42384539333735324644323430313430305f4d520a
2014.11.17 22:17:27.336 5: SONOS0: SetValues:SONOS:INTERVAL=30|targetSpeakFileHashCache=1|targetSpeakFileTimestamp=0|targetSpeakDir=%2Fopt%2Ffhem%2FSonosSpeak|NAME=Sonos|targetSpeakURL=%5C%5C192.168.1.12%5CSonosSpeak|UserID_Spotify=SA_RINCON2311_X_%2523Svc2311-0-Token
2014.11.17 22:17:27.336 5: SW: 53657456616c7565733a534f4e4f533a494e54455256414c3d33307c746172676574537065616b46696c654861736843616368653d317c746172676574537065616b46696c6554696d657374616d703d307c746172676574537065616b4469723d2532466f70742532466668656d253246536f6e6f73537065616b7c4e414d453d536f6e6f737c746172676574537065616b55524c3d2535432535433139322e3136382e312e3132253543536f6e6f73537065616b7c5573657249445f53706f746966793d53415f52494e434f4e323331315f585f2532353233537663323331312d302d546f6b656e0a
2014.11.17 22:17:27.338 5: SONOS0: SetValues:RINCON_000E58C74E4801400_MR:Balance=0|ZoneGroupName=Bad|location=http%3A%2F%2F192.168.1.150%3A1400%2Fxml%2Fdevice_description.xml|Mute=0|NAME=Sonos_Bad|SleepTimerVersion=0|minVolume=0|Loudness=1|Bass=-1|roomName=Bad|Volume=5|ZoneGroupID=RINCON_000E58C74E4801400%3A__|Treble=1|ZonePlayerUUIDsInGroup=RINCON_000E58C74E4801400|getAlarms=1|HeadphoneConnected=0|roomIcon=bathroom
2014.11.17 22:17:27.338 5: SW: 53657456616c7565733a52494e434f4e5f30303045353843373445343830313430305f4d523a42616c616e63653d307c5a6f6e6547726f75704e616d653d4261647c6c6f636174696f6e3d687474702533412532462532463139322e3136382e312e31353025334131343030253246786d6c2532466465766963655f6465736372697074696f6e2e786d6c7c4d7574653d307c4e414d453d536f6e6f735f4261647c536c65657054696d657256657273696f6e3d307c6d696e566f6c756d653d307c4c6f75646e6573733d317c426173733d2d317c726f6f6d4e616d653d4261647c566f6c756d653d357c5a6f6e6547726f757049443d52494e434f4e5f30303045353843373445343830313430302533415f5f7c547265626c653d317c5a6f6e65506c617965725555494473496e47726f75703d52494e434f4e5f30303045353843373445343830313430307c676574416c61726d733d317c4865616470686f6e65436f6e6e65637465643d307c726f6f6d49636f6e3d62617468726f6f6d0a
2014.11.17 22:17:27.341 5: SONOS0: SetValues:RINCON_000E58B7AF1401400_MR:ZoneGroupName=Kueche|location=http%3A%2F%2F192.168.1.149%3A1400%2Fxml%2Fdevice_description.xml|NAME=Sonos_Kueche|Mute=0|Balance=0|Bass=1|Treble=0|ZoneGroupID=RINCON_000E58B7AF1401400%3A__|Volume=14|roomName=Kueche|HeadphoneConnected=0|getAlarms=1|ZonePlayerUUIDsInGroup=RINCON_000E58B7AF1401400|roomIcon=kitchen|SleepTimerVersion=0|minVolume=0|Loudness=1
2014.11.17 22:17:27.341 5: SW: 53657456616c7565733a52494e434f4e5f30303045353842374146313430313430305f4d523a5a6f6e6547726f75704e616d653d4b75656368657c6c6f636174696f6e3d687474702533412532462532463139322e3136382e312e31343925334131343030253246786d6c2532466465766963655f6465736372697074696f6e2e786d6c7c4e414d453d536f6e6f735f4b75656368657c4d7574653d307c42616c616e63653d307c426173733d317c547265626c653d307c5a6f6e6547726f757049443d52494e434f4e5f30303045353842374146313430313430302533415f5f7c566f6c756d653d31347c726f6f6d4e616d653d4b75656368657c4865616470686f6e65436f6e6e65637465643d307c676574416c61726d733d317c5a6f6e65506c617965725555494473496e47726f75703d52494e434f4e5f30303045353842374146313430313430307c726f6f6d49636f6e3d6b69746368656e7c536c65657054696d657256657273696f6e3d307c6d696e566f6c756d653d307c4c6f75646e6573733d310a
2014.11.17 22:17:27.343 5: SONOS0: SetValues:RINCON_B8E93752FD2401400_MR:roomIcon=masterbedroom|getAlarms=1|ZonePlayerUUIDsInGroup=RINCON_B8E93752FD2401400|HeadphoneConnected=0|Volume=92|roomName=Schlafzimmer|ZoneGroupID=RINCON_B8E93752FD2401400%3A__|Treble=0|Bass=0|Loudness=1|minVolume=0|SleepTimerVersion=0|Mute=0|NAME=Sonos_Schlafzimmer|location=http%3A%2F%2F192.168.1.104%3A1400%2Fxml%2Fdevice_description.xml|ZoneGroupName=Schlafzimmer|Balance=0
2014.11.17 22:17:27.343 5: SW: 53657456616c7565733a52494e434f4e5f42384539333735324644323430313430305f4d523a726f6f6d49636f6e3d6d6173746572626564726f6f6d7c676574416c61726d733d317c5a6f6e65506c617965725555494473496e47726f75703d52494e434f4e5f42384539333735324644323430313430307c4865616470686f6e65436f6e6e65637465643d307c566f6c756d653d39327c726f6f6d4e616d653d5363686c61667a696d6d65727c5a6f6e6547726f757049443d52494e434f4e5f42384539333735324644323430313430302533415f5f7c547265626c653d307c426173733d307c4c6f75646e6573733d317c6d696e566f6c756d653d307c536c65657054696d657256657273696f6e3d307c4d7574653d307c4e414d453d536f6e6f735f5363686c61667a696d6d65727c6c6f636174696f6e3d687474702533412532462532463139322e3136382e312e31303425334131343030253246786d6c2532466465766963655f6465736372697074696f6e2e786d6c7c5a6f6e6547726f75704e616d653d5363686c61667a696d6d65727c42616c616e63653d300a
2014.11.17 22:17:27.345 5: SW: 53746172745468726561640a
2014.11.17 22:17:31.370 3: Device CUL_HM_HM_SEC_RHS_238E26 added to ActionDetector with 028:00 time
2014.11.17 22:17:31.380 3: Device dg_wz_fensterkontakt_links added to ActionDetector with 000:50 time
2014.11.17 22:17:31.382 3: Device dg_wz_fensterkontakt_rechts added to ActionDetector with 000:50 time
2014.11.17 22:17:31.383 3: Device dg_wz_heizkoerper added to ActionDetector with 000:10 time
2014.11.17 22:17:31.392 3: Device dg_wz_wandthermostat added to ActionDetector with 000:10 time
2014.11.17 22:17:31.397 3: Device og_bz_fensterkontakt added to ActionDetector with 000:50 time
2014.11.17 22:17:31.399 3: Device og_bz_heizkoerper added to ActionDetector with 000:10 time
2014.11.17 22:17:31.407 3: Device og_bz_wandthermostat added to ActionDetector with 000:10 time
2014.11.17 22:17:31.414 3: Device og_ez_fensterkontakt added to ActionDetector with 000:50 time
2014.11.17 22:17:31.416 3: Device og_ez_heizkoerper added to ActionDetector with 000:10 time
2014.11.17 22:17:31.425 3: Device og_ez_wandthermostat added to ActionDetector with 000:10 time
2014.11.17 22:17:31.431 3: Device og_schlieserschnittstelle added to ActionDetector with 028:00 time
2014.11.17 22:17:31.434 3: Device og_sz_fensterkontakt added to ActionDetector with 000:50 time
2014.11.17 22:17:31.436 3: Device og_sz_heizkoerper added to ActionDetector with 000:10 time
2014.11.17 22:17:31.444 3: Device og_sz_wandthermostat added to ActionDetector with 000:10 time


stdout:
>Smartmatch is experimental at ./FHEM/10_RESIDENTS.pm line 167, <$fh> line 3.
Smartmatch is experimental at ./FHEM/10_RESIDENTS.pm line 168, <$fh> line 3.
Smartmatch is experimental at ./FHEM/00_SONOS.pm line 3435.
Current: "fhem.pl", gPath: "./FHEM"
Smartmatch is experimental at FHEM/00_SONOS.pm line 3435.
Current: "FHEM/00_SONOS.pm", gPath: ""
2014.11.17 22:17:18 1: SONOS0: FHEM/00_SONOS.pm is listening to Port 4711
2014.11.17 22:17:26 1: SONOS0: Connection accepted from localhost:54835
2014.11.17 22:17:27 5: SONOS0: Received: 'SetValues:SONOS:INTERVAL=30|targetSpeakFileHashCache=1|targetSpeakFileTimestamp=0|targetSpeakDir=%2Fopt%2Ffhem%2FSonosSpeak|NAME=Sonos|targetSpeakURL=%5C%5C192.168.1.12%5CSonosSpeak|UserID_Spotify=SA_RINCON2311_X_%2523Svc2311-0-Token'


Danke dir!, Gruß Claudiu

Reinerlein

Hi Claudiu,

hmmm... das Problem ist eine fehlende Datenübertragung zur Initialisierung (Ich übertrage noch eine Sequenz "SetData", die ich im Empfangslog überhaupt nicht sehe).
Dazu ist mir dir Log-Ausgabe von DevIo_SimpleWrite() aufgefallen (das sind die Zeilen mit "SW " am Anfang).
Dort sollte im Normalfall ausgegeben werden, was übertragen werden wird. Hier scheint eine Ausgabe im Hex-Format zu erfolgen, was eigentlich nur der Fall sein sollte, wenn der dritte Parameter boolsch true gesetzt wurde. Ich tue das nicht, und übertrage immer eine 0 an der Stelle.

Ich habe bei mir den Code von SimpleWrite überprüft, und es steht so, wie ich es erwarte (und bei mir geht es ja auch).
Hier mal die kleine Sub-Prozedur von meinem Codestand:

sub
DevIo_SimpleWrite($$$)
{
  my ($hash, $msg, $ishex) = @_;
  return if(!$hash);

  my $name = $hash->{NAME};
  Log3 ($name, 5, $ishex ? "SW: $msg" : "SW: ".unpack("H*",$msg));

  $msg = pack('H*', $msg) if($ishex);
  $hash->{USBDev}->write($msg)    if($hash->{USBDev});
  syswrite($hash->{TCPDev}, $msg) if($hash->{TCPDev});
  syswrite($hash->{DIODev}, $msg) if($hash->{DIODev});
  select(undef, undef, undef, 0.001);
}
Sieht die bei dir anders aus? Wird die irgendwie durch ein anderes Modul vielleicht überschrieben?
-> Ich sehe gerade, dass diese Log-Ausgabe genau falsch herum geschrieben ist. Da kann man sich also nicht drauf verlassen... Aber die Variable $msg wird, zumindest hier, im korrekten Fall umgewandelt...

Kannst du deine Fhem-Konfiguration verringern, sodass im großen und ganzen nur Sonos drin ist?
Wie läuft es dann?

Grüße
Reinerlein

rapster

#34
Uff, das Problem scheint ja doch nicht so trivial wie gedacht...

Also die DevIo_SimpleWrite() sieht bei mir genau so aus, meine DevIo.pm => 6980 2014-11-15

Aus der fhem.cfg habe ich alles bis auf Sonos rausgeschmissen, hat aber leider nicht geholfen.

Ich habe jetzt nochmal mit Fhem verbose 5 und Sonos verbose 5 logs gemacht (mit sauberer fhem.cfg)

Verstehe grad nicht warum das nicht funktioniert, hab auch mal Sonos-Stable probiert, hier funktioniert es aber auch nicht.

die fhem.log im Anhang, sonos stdout hat sich nicht viel getan:
Smartmatch is experimental at ./FHEM/00_SONOS.pm line 3435.
Current: "fhem.pl", gPath: "./FHEM"
Smartmatch is experimental at FHEM/00_SONOS.pm line 3435.
Current: "FHEM/00_SONOS.pm", gPath: ""
2014.11.18 00:15:34 1: SONOS0: FHEM/00_SONOS.pm is listening to Port 4711
2014.11.18 00:15:42 1: SONOS0: Connection accepted from localhost:40577
2014.11.18 00:15:42 5: SONOS0: Received: 'DoWork:undef:setVerbose:5'
2014.11.18 00:15:43 5: SONOS0: Received: 'SetData:Sonos:5:none:Sonos_Bad,Sonos_Kueche,Sonos_Schlafzimmer:RINCON_000E58C74E4801400_MR,RINCON_000E58B7AF1401400_MR,RINCON_B8E93752FD2401400_MR'
2014.11.18 00:15:43 5: SONOS0: Received: 'SetValues:SONOS:targetSpeakDir=%2Fopt%2Ffhem%2FSonosSpeak|UserID_Spotify=SA_RINCON2311_X_%2523Svc2311-0-Token|targetSpeakFileTimestamp=0|targetSpeakURL=%5C%5C192.168.1.12%5CSonosSpeak|targetSpeakFileHashCache=1|NAME=Sonos|INTERVAL=30'


Ich bin mir nur fast sicher dass es gestern Abend noch funktionierte, nur was hätte sich seit dem ändern können?

EDIT:
Ich habe eben mal mein VM-Backup von Gestern Nacht 2:00 Uhr gebootet, hier funktioniert noch alles, auch nach einspielen der aktuellen Sonos-Dev

Ich prüfe mal Morgen was evtl. heute übern Tag schief gelaufen ist, das ist sehr merkwürdig.

Reinerlein

Hi Claudiu,

kann es das Attribut "verbose" am Sonos-Device sein?

Das hast du doch bestimmt erst später zum Testen gesetzt. Wenn es nicht gesetzt wird, wird automatisch der globale-verbose-Wert verwendet...

Grüße
Reinerlein

rapster

Moin Reinerlein :-)

Tatsächlich, das wars!  :o

Glaub auf die Idee wäre ich jetzt nie gekommen, hätte jetzt eine Konfig nach der anderen zerpflückt  ;D

Danke dir!!

Gruß Claudiu

Reinerlein

Hi Claudiu,

ok, dann schaue ich mir das mal an.

Das Modul versucht Attribute beim Setzen direkt an den Subprozess zu übertragen. Das darf er aber erst, wenn der Subprozess fertig mit initialisieren ist...

Danke fürs Testen..

Grüße
Reinerlein

rapster

Hi Reinerlein,

mal a Sache wenn du mal vll. etwas Zeit hast..

Wie verhällt es sich eigentlich mit dieser 8 Sekunden Pause beim fhem Start?

Muss diese wirklich hardcodiert auf 8 Sekunden stehen, oder lässt sich das Modul nicht insofern anpassen, dass die Verarbeitung dynamisch fortgesetzt wird sobald der UPnP-Server gefunden wurde, da ja der gesamte Fhem start hierdurch doch in die Länge gezogen wird?


2014.11.18 06:39:33.479 1: SONOS0: Kein UPnP-Server gefunden... Starte selber einen und warte 8 sekunden darauf...
2014.11.18 06:39:41.480 3: Opening Sonos device localhost:4711



Gruß Claudiu

rapster

Und evtl. noch eine Sache die mir aufgefallen ist  ;)

sobald man in fhem ein "rereadcfg", bzw. "reload ..." durchführt oder die fhem.cfg abspeichert, wandert das Sonos Modul in den Status "initialized".

Auch wenn man den Fhem Prozess stopt, sieht man dass das Sonos Modul weiter ausgeführt wird, und nach dem Fhem Start nichtmehr mit hochkommt:
root@fhem:~>service fhem stop
Stopping FHEM...
root@fhem:~>ps -ef | grep perl
root      2936     1  0 08:54 ?        00:00:06 perl FHEM/00_SONOS.pm 4711 3
root      3071  3022  0 09:54 pts/1    00:00:00 grep perl
root@fhem:~>service fhem start
Starting FHEM...
Process ID: 3081
root@fhem:~>Smartmatch is experimental at ./FHEM/10_RESIDENTS.pm line 167, <$fh> line 3.
Smartmatch is experimental at ./FHEM/10_RESIDENTS.pm line 168, <$fh> line 3.
Smartmatch is experimental at ./FHEM/00_SONOS.pm line 3435.
Current: "fhem.pl", gPath: "./FHEM"
root@fhem:~>


Erst wenn man den (alten) Sonos Perl Prozess per SIGTERM abschießt, fängt sich das Modul wieder und baut eine Verbindung auf. (Fhem muss nach dem SIGTERM nicht neu gestartet werden)

root@fhem:~>kill 2936
root@fhem:~>Smartmatch is experimental at FHEM/00_SONOS.pm line 3435.
Current: "FHEM/00_SONOS.pm", gPath: ""
2014.11.18 09:59:08 1: SONOS0: FHEM/00_SONOS.pm is listening to Port 4711
kill 29362014.11.18 09:59:15 1: SONOS0: Connection accepted from localhost:55470                                     service fhem start2014.11.18 09:59:16 3: SONOS1: UPnP-Thread gestartet.
Odd number of elements in hash assignment at FHEM/lib/UPnP/ControlPoint.pm line 30, <$client> line 6.
2014.11.18 09:59:16 1: SONOS2: Restore-Thread gestartet. Warte auf Arbeit...
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Discover Sonosplayer 'Schlafzimmer' (S1) Software Revision 5.2 with ID 'RINCON_B8E93752FD2401400_MR'
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: SonosPlayer 'Schlafzimmer' (S1) Software Revision 5.2 with ID 'RINCON_B8E93752FD2401400_MR' is already defined and will only be updated
2014.11.18 09:59:17 2: SONOS1: SonosPlayer 'Schlafzimmer' is now updated
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Service-subscribing successful with SID="uuid:RINCON_B8E93752FD2401400_sub0000000624" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Rendering-Service-subscribing successful with SID="uuid:RINCON_B8E93752FD2401400_sub0000000625" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Alarm-Service-subscribing successful with SID="uuid:RINCON_B8E93752FD2401400_sub0000000626" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: ZoneGroupTopology-Service-subscribing successful with SID="uuid:RINCON_B8E93752FD2401400_sub0000000627" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: DeviceProperties-Service-subscribing successful with SID="uuid:RINCON_B8E93752FD2401400_sub0000000628" and Timeout="86400s"
2014.11.18 09:59:17 3: SONOS1: Discover: End of discover-event for "Schlafzimmer".
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Discover Sonosplayer 'Bad' (S1) Software Revision 5.2 with ID 'RINCON_000E58C74E4801400_MR'
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: SonosPlayer 'Bad' (S1) Software Revision 5.2 with ID 'RINCON_000E58C74E4801400_MR' is already defined and will only be updated
2014.11.18 09:59:17 2: SONOS1: SonosPlayer 'Bad' is now updated
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Service-subscribing successful with SID="uuid:RINCON_000E58C74E4801400_sub0000000116" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Rendering-Service-subscribing successful with SID="uuid:RINCON_000E58C74E4801400_sub0000000117" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Alarm-Service-subscribing successful with SID="uuid:RINCON_000E58C74E4801400_sub0000000118" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: ZoneGroupTopology-Service-subscribing successful with SID="uuid:RINCON_000E58C74E4801400_sub0000000119" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: DeviceProperties-Service-subscribing successful with SID="uuid:RINCON_000E58C74E4801400_sub0000000120" and Timeout="86400s"
2014.11.18 09:59:17 3: SONOS1: Discover: End of discover-event for "Bad".
2014.11.18 09:59:17 3: SONOS1: Event: Received Transport-Event for Zone "Sonos_Schlafzimmer".
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 3: SONOS1: Event: End of Transport-Event for Zone "Sonos_Schlafzimmer".
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Discover Sonosplayer 'Kueche' (S9) Software Revision 5.2 with ID 'RINCON_000E58B7AF1401400_MR'
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: SonosPlayer 'Kueche' (S9) Software Revision 5.2 with ID 'RINCON_000E58B7AF1401400_MR' is already defined and will only be updated
2014.11.18 09:59:17 2: SONOS1: SonosPlayer 'Kueche' is now updated
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Service-subscribing successful with SID="uuid:RINCON_000E58B7AF1401400_sub0000000124" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Rendering-Service-subscribing successful with SID="uuid:RINCON_000E58B7AF1401400_sub0000000125" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: Alarm-Service-subscribing successful with SID="uuid:RINCON_000E58B7AF1401400_sub0000000126" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: ZoneGroupTopology-Service-subscribing successful with SID="uuid:RINCON_000E58B7AF1401400_sub0000000127" and Timeout="86400s"
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 2: SONOS1: DeviceProperties-Service-subscribing successful with SID="uuid:RINCON_000E58B7AF1401400_sub0000000128" and Timeout="86400s"
2014.11.18 09:59:17 3: SONOS1: Discover: End of discover-event for "Kueche".
2014.11.18 09:59:17 3: SONOS1: Event: Received Transport-Event for Zone "Sonos_Bad".
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 3: SONOS1: Event: End of Transport-Event for Zone "Sonos_Bad".
2014.11.18 09:59:17 3: SONOS1: Event: Received Alarm-Event for Zone "Sonos_Schlafzimmer".
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:17 3: SONOS1: Event: End of Alarm-Event for Zone "Sonos_Schlafzimmer".
2014.11.18 09:59:17 3: SONOS1: Event: Received Transport-Event for Zone "Sonos_Kueche".
2014.11.18 09:59:17 3: SONOS1: Event: End of Transport-Event for Zone "Sonos_Kueche".
2014.11.18 09:59:17 3: SONOS1: Event: Received Alarm-Event for Zone "Sonos_Bad".
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:18 3: SONOS1: Event: End of Alarm-Event for Zone "Sonos_Bad".
2014.11.18 09:59:18 3: SONOS1: Event: Received Alarm-Event for Zone "Sonos_Kueche".
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
2014.11.18 09:59:18 3: SONOS1: Event: End of Alarm-Event for Zone "Sonos_Kueche".
2014.11.18 09:59:18 3: SONOS1: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Schlafzimmer".
2014.11.18 09:59:18 3: SONOS1: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Schlafzimmer".
2014.11.18 09:59:18 3: SONOS1: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Bad".
2014.11.18 09:59:18 3: SONOS1: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Bad".
2014.11.18 09:59:18 3: SONOS1: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Kueche".
2014.11.18 09:59:18 3: SONOS1: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Kueche".
2014.11.18 09:59:18 3: SONOS1: Event: Received DeviceProperties-Event for Zone "Sonos_Kueche".
2014.11.18 09:59:18 3: SONOS1: Event: End of DeviceProperties-Event for Zone "Sonos_Kueche".
2014.11.18 09:59:18 3: SONOS1: Event: Received DeviceProperties-Event for Zone "Sonos_Schlafzimmer".
2014.11.18 09:59:18 3: SONOS1: Event: End of DeviceProperties-Event for Zone "Sonos_Schlafzimmer".
2014.11.18 09:59:18 3: SONOS1: Event: Received DeviceProperties-Event for Zone "Sonos_Bad".
2014.11.18 09:59:18 3: SONOS1: Event: End of DeviceProperties-Event for Zone "Sonos_Bad".
2014.11.18 09:59:18 3: SONOS1: Event: Received Rendering-Event for Zone "Sonos_Kueche".
2014.11.18 09:59:18 3: SONOS1: Event: End of Rendering-Event for Zone "Sonos_Kueche".
2014.11.18 09:59:18 3: SONOS1: Event: Received Rendering-Event for Zone "Sonos_Bad".
2014.11.18 09:59:18 3: SONOS1: Event: End of Rendering-Event for Zone "Sonos_Bad".
2014.11.18 09:59:18 3: SONOS1: Event: Received Rendering-Event for Zone "Sonos_Schlafzimmer".
2014.11.18 09:59:18 3: SONOS1: Event: End of Rendering-Event for Zone "Sonos_Schlafzimmer".
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 6.
root@fhem:~>


Gibt es hierfür einen Workaround oder fällt dir evtl. eine Lösung hierfür ein?

Gruß Claudiu

Reinerlein

Hi Claudiu,

mehrere Sachen:
- Man kann jetzt (erst aktualisieren!) beim Define als letzten Parameter hinter dem Interval eine Waittime in Sekunden angeben. Standardmäßig wird dort eine 8 angenommen (die einem guten Wert für einen Rapsberry Pi entspricht), und beliebig verändert werden. Wählt man ihn zu kurz, kann es sein, dass die Verbindung erst zum nächsten Prüfzyklus der TCP-Verbindung steht (ich meine das sind 60s).
- Das mit dem verbose bleibt ein komisches Verhalten bei dir :-) Ich konnte es nicht nachstellen, und im Code sieht das auch gut aus, und sollte eigentlich nicht das bei dir vorhandene Szenario ergeben. Da bin ich momentan echt überfragt...
- Das mit rereadcfg und co. habe ich damals schon ausführlich untersucht. Leider konnte ich keine machbare Lösung finden, und gebe (wie auch Rudi selbst) allgemein die Empfehlung ab, nur "shutdown restart" zu verwenden. Dort klappt das Beenden und Neustarten des Subprozesses Ordnungsgemäß...

Grüße
Reinerlein

rapster

#41
Hi Reinerlein,

mensch du bist ja super flott ;)

- Funzt super, und bin vollkommen zufrieden mit dieser Lösung  :D
  Wenn ich als Waittime 1 eingebe funktioniert alles perfekt.
  Wenn ich als Waittime 0 eingebe startet Sonos wie du sagtest nach ~60 sec
  Nur mit Werten <1 (wie 0.5) scheint es nicht zu klappen (es wird nicht gewartet, wie 0), oder muss ich hier den Wert anderst angeben?
2014.11.18 12:56:01.691 1: SONOS0: Kein UPnP-Server gefunden... Starte selber einen und warte 0.5 sekunden darauf...
2014.11.18 12:56:01.692 3: Opening Sonos device localhost:4711


- Hm, ja wirklich seltsam, ist aber auch nicht wirklich schlimm, hatte ja verbose sowieso auf 3 gesetzt (scheint auch default zu sein) und zur Fehlerbehebung falls mal verbose 5 benötigt wird, funktioniert der Workaroung ja temporär auch.
  > evtl. sollte auf dieses Problem nur im Wiki hingewiesen werden, falls noch jemand hierauf stößt?

- OK, habe meistens sowieso restart benutzt (in meiner fhem.cfg sind nur includes drin).
  Und nachdem Fhem jetzt nurnoch ~5 Sekunden (incl. Sonos Geräte einlesen) zum starten braucht ( - 7 Sek durch Sonos-Waittime ;) ) ist das auch sehr erträglich.

Nochmal ein dickes Danke von mir für deine Mühe!!

Gruß Claudiu

Reinerlein

Hi Claudiu,

so noch ein Nachtrag zur Waittime.
Da stand vorher ein einfaches Sleep, welches nur ganze Zahlen konnte. Ich habe dort nun ein select() hingepackt, welches auch Kommazahlen beherrscht.
Man kann jetzt also bequem 0.1 Sekunden einstellen, die übrigens auf meinem Test-Windows-System auch vollkommen ausreichen...

Grüße
Reinerlein

rapster

Hi Reinerlein,

danke, das klappt wunderbar!

0.1 Sekunden haben bei mir zwar nicht gereicht, ich habe es jetzt mal auf 0.5 gestellt, hier scheint alles super zu starten  :D

Gruß Claudiu

rapster

#44
Hi Reinerlein,

zur Info...

Zitat- Das mit rereadcfg und co. habe ich damals schon ausführlich untersucht. Leider konnte ich keine machbare Lösung finden, und gebe (wie auch Rudi selbst) allgemein die Empfehlung ab, nur "shutdown restart" zu verwenden. Dort klappt das Beenden und Neustarten des Subprozesses Ordnungsgemäß...

Habe (für mich zumindest) für das Problem dass das Sonos-Modul nach einem rereadcfg, speichern von fhem.cfg u.ä. nicht mehr hoch kommt ein Workaround gebaut.

Durch ein einfaches notify welches auf dieses Ereignis den alten Sonos-Prozess beendet. (Es wird ja automatisch ein neuer gestartet).
define ntfy_sonosRereadcfg notify global:REREADCFG { `kill \$(ps aux | grep 00_[S]ONOS | awk '{print \$2}')` }

Funktioniert bei mir zumindest einwandfrei, und das Sonos-Modul ist nach einem rereadcfg wieder voll einsatzbereit  :D


> Oder siehst du irgendwelche Bedenken die gegen diese Lösung sprechen?


Gruß Claudiu