Fehlerhafte initMessage (+) bei Geraeten mit aesCommReq

[mgernoth]

Hallo Martin,

done

Danke

Es wird aber die falsche Funktion aufgerufen, die die schon gecachte init-Message nochmal schickt. Ich hab das mal geaendert und auch den Timer nach der Definition einer VCCU neugestartet.
Mit anhaengendem Diff gehts jetzt bei mir vollstaendig.

Viele Gruesse
  Michael

[frank]

meine fensterkontakte werden nun entsprechend "richtig" initializiert.

beim umassignen der io's besteht aber wohl weiterhin ein problem. hier wird nie MASK an das neue io übergeben. der parameter fehlt grundsätzlich.

Code Auswählen Erweitern

2015.07.06 09:47:40.192 0: HMLAN_Send:  hmusb1 I:+83765A,00,00,00
2015.07.06 09:47:41.300 0: HMLAN_Send:  hmusb1 I:-83765A
2015.07.06 09:47:41.304 0: HMLAN_Send:  hmlan1 I:+83765A,00,00,


darüber hinaus wundere ich mich, dass nach restart manchen devices erst ein "falsches" io assigned wird, um es augenblicke später dem gesetzten prefered-io zu assignen. das device 6869B6 wird sogar 2x umassigned. zuerst richtiges prefered-io hmusb1, dann hmlan1 und zurück zu hmusb1.
dazu mal ein ungekürztes log nach restart.

Code Auswählen Erweitern

2015.07.06 15:06:46.219 1: Including fhem.cfg
2015.07.06 15:06:49.363 1: HMLAN_Parse: hmusb1 new condition disconnected
2015.07.06 15:06:49.448 1: HMLAN_Parse: hmusb1 new condition init
2015.07.06 15:06:49.481 1: HMLAN_Parse: hmlan1 new condition disconnected
2015.07.06 15:06:49.502 1: HMLAN_Parse: hmlan1 new condition init
2015.07.06 15:07:13.289 0: HourCounter Pumpe.Garten.Brunnen.Cnt Define.228 parameters: Pumpe.Garten.Brunnen.Cnt HourCounter SwitchES01_Pwr:current:\s[0-9]{4,}$ SwitchES01_Pwr:current:\s[0-9]{1,2}$
2015.07.06 15:07:13.761 0: HourCounter hc_system_attak Define.228 parameters: hc_system_attak HourCounter ccu:system_attack:.on ccu:system_attack:.off
2015.07.06 15:07:13.828 1: Including ./log/fhem.save
2015.07.06 15:07:22.332 1: PERL WARNING: Use of uninitialized value $n in hash element at fhem.pl line 3454.
2015.07.06 15:07:22.377 1: PERL WARNING: Use of uninitialized value $n in hash element at fhem.pl line 3454.
2015.07.06 15:07:22.421 1: PERL WARNING: Use of uninitialized value $n in hash element at fhem.pl line 3454.
2015.07.06 15:07:22.466 1: PERL WARNING: Use of uninitialized value $n in hash element at fhem.pl line 3454.
2015.07.06 15:07:22.507 1: PERL WARNING: Use of uninitialized value $n in hash element at fhem.pl line 3454.
2015.07.06 15:07:29.678 1: HCS BROETJE monitoring of devices started
2015.07.06 15:07:33.536 1: PERL WARNING: Subroutine HandleTimeout redefined at ./FHEM/98_apptime.pm line 24.
2015.07.06 15:07:33.543 1: PERL WARNING: Subroutine CallFn redefined at ./FHEM/98_apptime.pm line 58.
2015.07.06 15:07:37.317 0: Server started with 318 defined entities (version $Id: fhem.pl 8574 2015-05-14 07:59:32Z rudolfkoenig $, os linux, user root, pid 3049)
2015.07.06 15:07:38.131 1: Perfmon: possible freeze starting at 15:06:47, delay is 51.13
2015.07.06 15:07:40.452 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:07:40.460 0: HMLAN_Send:  hmlan1 I:K
2015.07.06 15:07:40.631 0: HourCounter hc_system_attak Run.598 first run done countsOverall:22
2015.07.06 15:07:40.771 0: HourCounter Pumpe.Garten.Brunnen.Cnt Run.598 first run done countsOverall:140
2015.07.06 15:07:41.252 0: HMLAN_Send:  hmusb1 I:+266A86,00,00,00
2015.07.06 15:07:41.256 0: HMLAN_Send:  hmusb1 I:+1F64D8,00,00,00
2015.07.06 15:07:41.259 0: HMLAN_Send:  hmlan1 I:+1C1BE3,00,00,00
2015.07.06 15:07:41.263 0: HMLAN_Send:  hmusb1 I:+52C4DF,00,00,00
2015.07.06 15:07:41.266 0: HMLAN_Send:  hmusb1 I:+52BB90,00,00,00
2015.07.06 15:07:41.270 0: HMLAN_Send:  hmusb1 I:+52BB9D,00,00,00
2015.07.06 15:07:41.273 0: HMLAN_Send:  hmlan1 I:+24AF1D,00,00,00
2015.07.06 15:07:41.277 0: HMLAN_Send:  hmusb1 I:+266EA5,00,00,00
2015.07.06 15:07:41.280 0: HMLAN_Send:  hmusb1 I:+266E75,00,00,00
2015.07.06 15:07:41.283 0: HMLAN_Send:  hmusb1 I:+285A54,00,00,00
2015.07.06 15:07:41.286 0: HMLAN_Send:  hmlan1 I:+285A44,00,00,00
2015.07.06 15:07:41.290 0: HMLAN_Send:  hmusb1 I:+206278,00,00,00
2015.07.06 15:07:41.293 0: HMLAN_Send:  hmusb1 I:+1936FF,00,00,00
2015.07.06 15:07:41.296 0: HMLAN_Send:  hmusb1 I:+206487,00,00,00
2015.07.06 15:07:41.299 0: HMLAN_Send:  hmusb1 I:+2064CB,00,00,00
2015.07.06 15:07:41.303 0: HMLAN_Send:  hmusb1 I:+206219,00,00,00
2015.07.06 15:07:41.325 0: HMLAN_Send:  hmusb1 I:+1D252E,00,00,00
2015.07.06 15:07:41.331 0: HMLAN_Send:  hmusb1 I:+20DFE1,00,00,00
2015.07.06 15:07:41.335 0: HMLAN_Send:  hmusb1 I:+1DFDA5,00,00,00
2015.07.06 15:07:41.338 0: HMLAN_Send:  hmusb1 I:+1BF81B,00,00,00
2015.07.06 15:07:41.341 0: HMLAN_Send:  hmusb1 I:+1DE620,00,00,00
2015.07.06 15:07:41.344 0: HMLAN_Send:  hmusb1 I:+1DF7C6,00,00,00
2015.07.06 15:07:41.347 0: HMLAN_Send:  hmlan1 I:+1C4E25,00,00,00
2015.07.06 15:07:41.350 0: HMLAN_Send:  hmlan1 I:+193A9A,00,00,00
2015.07.06 15:07:41.353 0: HMLAN_Send:  hmlan1 I:+1BFC52,00,00,00
2015.07.06 15:07:41.357 0: HMLAN_Send:  hmlan1 I:+1F91AA,00,00,00
2015.07.06 15:07:41.361 0: HMLAN_Send:  hmlan1 I:+1DFC2F,00,00,00
2015.07.06 15:07:41.364 0: HMLAN_Send:  hmlan1 I:+1CE9F5,00,00,00
2015.07.06 15:07:41.368 0: HMLAN_Send:  hmusb1 I:+83765A,00,00,00
2015.07.06 15:07:41.371 0: HMLAN_Send:  hmusb1 I:+6869B6,00,00,00
2015.07.06 15:07:41.396 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:0290F433 IDcnt:000E L:7 %
2015.07.06 15:07:41.575 0: HMLAN_Send:  hmusb1 I:+20DFE1,02,00,00
2015.07.06 15:07:42.136 0: HMLAN_Send:  hmusb1 I:+2064CB,02,00,00
2015.07.06 15:07:42.677 0: HMLAN_Send:  hmusb1 I:+206219,02,00,00
2015.07.06 15:07:43.129 0: HMLAN_Send:  hmusb1 I:+206278,02,00,00
2015.07.06 15:07:43.417 0: HMLAN_Send:  hmusb1 I:+1DFDA5,02,00,00
2015.07.06 15:07:44.725 0: HMLAN_Send:  hmusb1 I:+1D252E,02,00,00
2015.07.06 15:07:44.901 0: HMLAN_Send:  hmusb1 I:+206487,02,00,00
2015.07.06 15:07:45.320 0: HMLAN_Send:  hmusb1 I:+1936FF,02,00,00
2015.07.06 15:07:45.713 0: IT set IT03 off
2015.07.06 15:07:46.328 0: IT set IT08 off
2015.07.06 15:07:47.695 0: HMLAN_Send:  hmusb1 I:+1BF81B,02,00,00
2015.07.06 15:07:49.714 1: HMLAN_Parse: hmlan1 new condition ok
2015.07.06 15:07:50.013 0: HMLAN_Send:  hmusb1 I:-206487
2015.07.06 15:07:50.017 0: HMLAN_Send:  hmlan1 I:+206487,00,00,
2015.07.06 15:07:50.282 0: HMLAN_Send:  hmusb1 I:-1D252E
2015.07.06 15:07:50.450 0: HMLAN_Send:  hmusb1 I:-1936FF
2015.07.06 15:07:50.497 0: HMLAN_Send:  hmusb1 I:-6869B6
2015.07.06 15:07:50.500 0: HMLAN_Send:  hmlan1 I:+6869B6,00,00,
2015.07.06 15:07:50.746 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:0291BB4E IDcnt:000E L:7 %
2015.07.06 15:07:50.754 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:014F3A07 IDcnt:0010 L:6 %
2015.07.06 15:07:51.408 1: HMLAN_Parse: hmusb1 new condition ok
2015.07.06 15:07:52.109 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:01500165 IDcnt:0015 L:6 %
2015.07.06 15:07:52.312 1: Perfmon: possible freeze starting at 15:07:39, delay is 13.311
2015.07.06 15:07:52.991 0: HMLAN_Send:  hmlan1 I:-1936FF
2015.07.06 15:07:53.044 0: HMLAN_Send:  hmlan1 I:-1D252E
2015.07.06 15:07:55.209 1: Perfmon: possible freeze starting at 15:07:53, delay is 2.208
2015.07.06 15:07:56.697 0: HMLAN_Send:  hmusb1 I:-52C4DF
2015.07.06 15:07:56.708 0: HMLAN_Send:  hmlan1 I:+52C4DF,00,00,
2015.07.06 15:07:58.155 0: HMLAN_Send:  hmusb1 I:-52BB90
2015.07.06 15:07:58.167 0: HMLAN_Send:  hmlan1 I:+52BB90,00,00,
2015.07.06 15:07:59.190 0: HMLAN_Send:  hmlan1 I:+1BFC52,02,00,00
2015.07.06 15:07:59.365 0: HMLAN_Send:  hmusb1 I:-52BB9D
2015.07.06 15:07:59.374 0: HMLAN_Send:  hmlan1 I:+52BB9D,00,00,
2015.07.06 15:08:00.135 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:08:00.246 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:01504E84 IDcnt:000E L:7 %
2015.07.06 15:08:00.776 0: HMLAN_Send:  hmusb1 I:+1936FF,00,00,
2015.07.06 15:08:01.303 0: HMLAN_Send:  hmlan1 I:K
2015.07.06 15:08:01.331 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:02920CBD IDcnt:0010 L:13 %
2015.07.06 15:08:01.581 0: HMLAN_Send:  hmlan1 I:-206487
2015.07.06 15:08:01.585 0: HMLAN_Send:  hmusb1 I:+206487,00,00,
2015.07.06 15:08:01.725 0: HMLAN_Send:  hmlan1 I:+1BFC52,00,00,00
2015.07.06 15:08:04.594 0: HMLAN_Send:  hmusb1 I:+1D252E,00,00,
2015.07.06 15:08:07.600 0: HMLAN_Send:  hmusb1 I:-266EA5
2015.07.06 15:08:08.781 0: HMLAN_Send:  hmlan1 I:+266EA5,00,00,
2015.07.06 15:08:11.169 0: HMLAN_Send:  hmlan1 I:K
2015.07.06 15:08:11.185 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:02923348 IDcnt:000F L:17 %
2015.07.06 15:08:17.639 0: HMLAN_Send:  hmlan1 I:K
2015.07.06 15:08:17.666 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:02924CA4 IDcnt:000F L:19 %
2015.07.06 15:08:25.140 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:08:25.205 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0150B005 IDcnt:0010 L:8 %
2015.07.06 15:08:27.233 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:08:27.350 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0150B865 IDcnt:0010 L:8 %
2015.07.06 15:08:29.040 0: HMLAN_Send:  hmusb1 I:+1BF81B,00,00,00
2015.07.06 15:08:42.644 0: HMLAN_Send:  hmlan1 I:K
2015.07.06 15:08:42.655 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:0292AE42 IDcnt:000F L:20 %
2015.07.06 15:08:46.608 0: HMLAN_Send:  hmusb1 I:+1DFDA5,00,00,00
2015.07.06 15:08:52.240 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:08:52.277 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:015119C4 IDcnt:0010 L:9 %
2015.07.06 15:08:59.954 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:09:00.053 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:01513824 IDcnt:0010 L:9 %
2015.07.06 15:09:01.930 0: HMLAN_Send:  hmusb1 I:+20DFE1,00,00,00
2015.07.06 15:09:07.651 0: HMLAN_Send:  hmlan1 I:K
2015.07.06 15:09:07.663 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:02930FF5 IDcnt:000F L:20 %
2015.07.06 15:09:18.125 0: HMLAN_Send:  hmusb1 I:+206487,00,00,00
2015.07.06 15:09:24.544 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:09:24.661 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:01519843 IDcnt:0010 L:9 %
2015.07.06 15:09:27.053 0: HMLAN_Send:  hmusb1 I:+206278,00,00,00
2015.07.06 15:09:29.354 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:09:29.524 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0151AB43 IDcnt:0010 L:10 %
2015.07.06 15:09:29.612 0: HMLAN_Send:  hmusb1 I:+2064CB,00,00,00
2015.07.06 15:09:32.647 0: HMLAN_Send:  hmlan1 I:K
2015.07.06 15:09:32.658 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:0293719D IDcnt:000F L:20 %
2015.07.06 15:09:32.853 0: HMLAN_Send:  hmusb1 I:+1D252E,00,00,00
2015.07.06 15:09:47.889 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:09:48.052 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0151F3A3 IDcnt:0010 L:11 %
2015.07.06 15:09:48.142 0: HMLAN_Send:  hmusb1 I:+1936FF,00,00,00
2015.07.06 15:09:57.656 0: HMLAN_Send:  hmlan1 I:K
2015.07.06 15:09:57.672 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:0293D353 IDcnt:000F L:20 %
2015.07.06 15:10:12.897 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:10:12.948 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:015254E3 IDcnt:0010 L:11 %
2015.07.06 15:10:22.660 0: HMLAN_Send:  hmlan1 I:K
2015.07.06 15:10:22.671 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:02943502 IDcnt:000F L:20 %
2015.07.06 15:10:37.904 0: HMLAN_Send:  hmusb1 I:K
2015.07.06 15:10:37.972 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0152B6A2 IDcnt:0010 L:11 %
2015.07.06 15:10:46.117 0: HMLAN_Send:  hmlan1 I:-6869B6
2015.07.06 15:10:46.121 0: HMLAN_Send:  hmusb1 I:+6869B6,00,00,


gruss frank

[martinp876]

ist etwas entschärft. Doppelt sollte es nicht kommen. Aber wenn kein preffered Device gesetzt ist wird eines gesucht - das kann natürlich wechseln.

[mgernoth]

Hi Martin,

ist etwas entschärft. Doppelt sollte es nicht kommen. Aber wenn kein preffered Device gesetzt ist wird eines gesucht - das kann natürlich wechseln.

hier sieht alles gut aus, Danke

Einen kleinen Patch habe ich noch: bisher kommen keine trig_aes_XXX-Trigger fuer Geraete ohne explizit angelegte Channels (z.B. TFK). Das ist in dem Patch behoben.

Viele Gruesse
  Michael