Ankündigung

Einklappen
Keine Ankündigung bisher.

- √ - knx_init - Nicht alle items werden aktualisiert

Einklappen
X
 
  • Filter
  • Zeit
  • Anzeigen
Alles löschen
neue Beiträge

    - √ - knx_init - Nicht alle items werden aktualisiert

    Hallo,

    ich habe mit dem RaspberryPi Image eine kleine Visualisierung erstellt. Es funktioniert auch alles, es werden beim Start aber nicht alle items mit 'knx_init' initialisiert. Im Gruppenmonitor der ETS4 sehe ich, dass nicht alle items abgefragt werden.

    Um Fehler auszuschliessen habe ich das RPi Image neu installiert und lediglich 4 items angelegt. Von den 4 items werden bei einem kompletten Neustart (Spannungsversorgung vom RPi aus/an) lediglich 3 aktualisiert. Bei einem anschliessenden Neustart per Komanndozeile werden nur 2 items aktualisiert.

    Im laufenden Betrieb funktionieren die Rückmeldungen problemlos.

    Anbei die entsprechenden conf, html und log Dateien:

    Code:
    [room1]
        [[bel1]]
            type = bool
            visu = yes
            knx_dpt = 1
            knx_send = 1/1/17
            knx_listen = 13/3/17
            knx_init = 13/3/17
        [[bel2]]
            type = bool
            visu = yes
            knx_dpt = 1
            knx_send = 1/1/18
            knx_listen = 13/3/18
            knx_init = 13/3/18
        [[bel3]]
            type = bool
            visu = yes
            knx_dpt = 1
            knx_send = 1/1/19
            knx_listen = 13/3/19
            knx_init = 13/3/19
        [[bel4]]
            type = bool
            visu = yes
            knx_dpt = 1
            knx_send = 1/1/20
            knx_listen = 13/3/20
            knx_init = 13/3/20
    Code:
    <div class="block">
            <div class="set-2" data-role="collapsible-set" data-theme="c" data-content-theme="a" data-mini="true">
                <div data-role="collapsible" data-collapsed="false" >
                    <h3>Light</h3>
                    {{ basic.switch('room1-bel1', 'room1.bel1') }}
                    Beleuchtung 1<br />
                    {{ basic.switch('room1-bel2', 'room1.bel2') }}
                    Beleuchtung 2<br />
                    {{ basic.switch('room1-bel3', 'room1.bel3') }}
                    Beleuchtung 3<br />
                    {{ basic.switch('room1-bel4', 'room1.bel4') }}
                    Beleuchtung 4
                </div>
            </div>
        </div>
    Code:
    2013-08-12 16:04:02 SmartHome.py INFO     Start SmartHome.py 0.9-10-g63eb637
    2013-08-12 16:04:02 SmartHome.py INFO     Init Scheduler
    2013-08-12 16:04:02 SmartHome.py INFO     Init Plugins
    2013-08-12 16:04:02 SmartHome.py ERROR    Onewire: could not connect to 127.0.0.1:4304: [Errno 111] Connection refused
    2013-08-12 16:04:03 SmartHome.py INFO     Init Items
    2013-08-12 16:04:04 SmartHome.py INFO     Start Plugins
    2013-08-12 16:04:04 SmartHome.py INFO     Start Logics
    2013-08-12 16:04:04 sh.con       INFO     KNX: connected to 127.0.0.1:6720
    2013-08-12 16:04:05 SmartHome.py INFO     WebSocket: incoming connection from 192.168.1.32:51511
    2013-08-12 16:04:05 SmartHome.py INFO     WebSocket: incoming connection from 192.168.1.32:51515
    2013-08-12 16:04:09 hello        INFO     Hello World!

    #2
    Hallo gth,

    herzlich Willkommen hier im Forum und als SmartHome.Pi Benutzer.
    Bitte gib in Deinem Profil noch Deinen echten Vornamen an. Danke.

    Mir fehlt noch ein Debug Log (smarthome.py mit -n starten) um den Fehler besser zu verstehen. Siehe auch:
    https://knx-user-forum.de/smarthome-...rbehebung.html

    Bis bald

    Marcus

    Kommentar


      #3
      Was für eine KNX-Schnittstelle? Telegrammraten-Begrenzung?

      Kommentar


        #4
        Als Schnittstelle verwende ich die MDT SCN-IP000.01. Der Schaltaktor, von dem die Rückmeldungen kommen, ist ein MDT AKS-2016.02. Eine Telegrammratenbegrenzung habe ich nicht festgelegt.

        Anbei der Debug Log. Alle 4 items waren eingeschaltet. Als AN wurden nur bel1 und bel4 angezeigt.

        Danke für die Hilfe.

        Code:
        2013-08-12 18:27:05 SmartHome.py INFO     Number of Threads: 8
        2013-08-12 18:27:05 SmartHome.py INFO     Stop Plugins
        2013-08-12 18:27:05 SmartHome.py INFO     KNX: connection to 127.0.0.1:6720 closed
        2013-08-12 18:27:06 SmartHome.py INFO     SmartHome.py stopped
        2013-08-12 18:27:57,534 SmartHome.py INFO     Start SmartHome.py 0.9-10-g63eb637 -- smarthome.py:__init__:192
        2013-08-12 18:27:57,539 SmartHome.py DEBUG    Python 2.7.3 -- smarthome.py:__init__:193
        2013-08-12 18:27:57,547 SmartHome.py INFO     Init Scheduler -- scheduler.py:__init__:53
        2013-08-12 18:27:57,553 SmartHome.py INFO     Init Plugins -- smarthome.py:__init__:208
        2013-08-12 18:27:57,564 Scheduler    DEBUG    creating 5 workers -- scheduler.py:run:59
        2013-08-12 18:27:57,577 SmartHome.py DEBUG    Plugin: knx -- plugin.py:__init__:42
        2013-08-12 18:27:57,617 SmartHome.py DEBUG    Plugin: ow -- plugin.py:__init__:42
        2013-08-12 18:27:57,637 SmartHome.py ERROR    Onewire: could not connect to 127.0.0.1:4304: [Errno 111] Connection refused -- __init__.py:connect:62
        2013-08-12 18:27:57,643 SmartHome.py DEBUG    Plugin: cli -- plugin.py:__init__:42
        2013-08-12 18:27:57,657 SmartHome.py DEBUG    Plugin: visu -- plugin.py:__init__:42
        2013-08-12 18:27:57,739 SmartHome.py DEBUG    Plugin: sql -- plugin.py:__init__:42
        2013-08-12 18:27:57,767 SmartHome.py DEBUG    SQLite 3.7.13 -- __init__.py:__init__:60
        2013-08-12 18:27:57,794 SmartHome.py DEBUG    sqlite next time: 2013-08-13 03:02:00+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:27:57,799 SmartHome.py DEBUG    Plugin: rrd -- plugin.py:__init__:42
        2013-08-12 18:27:57,899 SmartHome.py INFO     Init Items -- smarthome.py:__init__:210
        2013-08-12 18:27:58,088 SmartHome.py DEBUG    knx: second.sleeping.light.level listen on 3/2/14 -- __init__.py:parse_item:230
        2013-08-12 18:27:58,094 SmartHome.py DEBUG    knx: Light listen on 3/2/12 -- __init__.py:parse_item:230
        2013-08-12 18:27:58,214 SmartHome.py DEBUG    knx: room1.bel1 listen on 13/3/17 -- __init__.py:parse_item:230
        2013-08-12 18:27:58,218 SmartHome.py DEBUG    knx: room1.bel1 listen on and init with 13/3/17 -- __init__.py:parse_item:239
        2013-08-12 18:27:58,227 SmartHome.py DEBUG    knx: room1.bel2 listen on 13/3/18 -- __init__.py:parse_item:230
        2013-08-12 18:27:58,231 SmartHome.py DEBUG    knx: room1.bel2 listen on and init with 13/3/18 -- __init__.py:parse_item:239
        2013-08-12 18:27:58,240 SmartHome.py DEBUG    knx: room1.bel3 listen on 13/3/19 -- __init__.py:parse_item:230
        2013-08-12 18:27:58,245 SmartHome.py DEBUG    knx: room1.bel3 listen on and init with 13/3/19 -- __init__.py:parse_item:239
        2013-08-12 18:27:58,253 SmartHome.py DEBUG    knx: room1.bel4 listen on 13/3/20 -- __init__.py:parse_item:230
        2013-08-12 18:27:58,258 SmartHome.py DEBUG    knx: room1.bel4 listen on and init with 13/3/20 -- __init__.py:parse_item:239
        2013-08-12 18:27:58,379 SmartHome.py INFO     Start Plugins -- plugin.py:start:63
        2013-08-12 18:27:58,389 ow           DEBUG    1w-disc next time: 2013-08-12 18:27:58+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:27:58,420 SmartHome.py INFO     Start Logics -- logic.py:__init__:32
        2013-08-12 18:27:58,417 rrd          DEBUG    rrd next time: 2013-08-12 18:29:38+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:27:58,429 SmartHome.py DEBUG    reading logics from /usr/smarthome/etc/logic.conf -- logic.py:__init__:38
        2013-08-12 18:27:58,449 SmartHome.py DEBUG    Logic: hello -- logic.py:__init__:45
        2013-08-12 18:27:58,507 SmartHome.py DEBUG    Logic: dummy -- logic.py:__init__:45
        2013-08-12 18:27:58,523 SmartHome.py DEBUG    dummy next time: 2013-08-12 18:28:05+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:27:58,568 sh.con       DEBUG    knx: enable group monitor -- __init__.py:handle_connect:110
        2013-08-12 18:27:58,571 visu         DEBUG    series next time: 2013-08-12 18:28:04+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:27:58,580 sh.con       DEBUG    knx: init read -- __init__.py:handle_connect:116
        2013-08-12 18:27:58,592 sh.con       INFO     KNX: connected to 127.0.0.1:6720 -- my_asynchat.py:connect:69
        2013-08-12 18:27:58,714 Scheduler    DEBUG    1w-disc next time: 2013-08-12 18:37:58+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:27:58,787 sh.gc        DEBUG    Garbage collector: collected 907 objects. -- smarthome.py:_garbage_collection:345
        2013-08-12 18:27:58,939 Scheduler    DEBUG    sh.gc next time: 2013-08-13 02:04:00+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:27:59,546 SmartHome.py DEBUG    0.0.0 read 13/3/17 -- __init__.py:parse_telegram:198
        2013-08-12 18:27:59,552 SmartHome.py DEBUG    0.0.0 read 13/3/18 -- __init__.py:parse_telegram:198
        2013-08-12 18:27:59,557 SmartHome.py DEBUG    0.0.0 read 13/3/19 -- __init__.py:parse_telegram:198
        2013-08-12 18:27:59,562 SmartHome.py DEBUG    0.0.0 read 13/3/20 -- __init__.py:parse_telegram:198
        2013-08-12 18:27:59,567 SmartHome.py DEBUG    knx: 1.1.50 set 13/3/17 to True -- __init__.py:parse_telegram:185
        2013-08-12 18:27:59,572 SmartHome.py DEBUG    room1.bel1 = True via KNX 1.1.50 -- item.py:_update:219
        2013-08-12 18:27:59,586 SmartHome.py DEBUG    knx: 1.1.50 set 13/3/20 to True -- __init__.py:parse_telegram:185
        2013-08-12 18:27:59,591 SmartHome.py DEBUG    room1.bel4 = True via KNX 1.1.50 -- item.py:_update:219
        2013-08-12 18:27:59,604 SmartHome.py DEBUG    knx: 0.0.0 set 1/1/17 to 1 -- __init__.py:parse_telegram:180
        2013-08-12 18:27:59,613 SmartHome.py DEBUG    knx: 0.0.0 set 1/1/20 to 1 -- __init__.py:parse_telegram:180
        2013-08-12 18:28:02,212 hello        INFO     Hello World! -- hello.py:<module>:3
        2013-08-12 18:28:04,394 Scheduler    DEBUG    series next time: 2013-08-12 18:28:14+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:28:05,031 dummy        DEBUG    first.living.humidity = 53 via Logic None -- item.py:_update:219
        2013-08-12 18:28:05,208 Scheduler    DEBUG    dummy next time: 2013-08-12 18:33:05+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:28:06,964 dummy        DEBUG    second.sleeping.temperature = 21 via Logic None -- item.py:_update:219
        2013-08-12 18:28:08,881 dummy        DEBUG    second.bath.temperature = 24 via Logic None -- item.py:_update:219
        2013-08-12 18:28:14,295 Scheduler    DEBUG    series next time: 2013-08-12 18:28:24+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:28:24,404 Scheduler    DEBUG    series next time: 2013-08-12 18:28:34+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:28:27,204 SmartHome.py INFO     WebSocket: incoming connection from 192.168.1.32:53387 -- __init__.py:handle_accept:115
        2013-08-12 18:28:27,437 SmartHome.py DEBUG    192.168.1.32:53387 sent '{"cmd":"proto","ver":2}' -- __init__.py:json_parse:257
        2013-08-12 18:28:31,180 SmartHome.py DEBUG    192.168.1.32:53387 sent '{"cmd":"monitor","items":["room1.bel1","room1.bel2","room1.bel3","room1.bel4"]}' -- __init__.py:json_parse:257
        2013-08-12 18:28:34,350 Scheduler    DEBUG    series next time: 2013-08-12 18:28:44+02:00 -- scheduler.py:_next_time:238
        2013-08-12 18:28:42,066 SmartHome.py DEBUG    WebSocket: closing connection to 192.168.1.32:53387. -- __init__.py:rfc6455_parse:380
        2013-08-12 18:28:44,248 Scheduler    DEBUG    series next time: 2013-08-12 18:28:54+02:00 -- scheduler.py:_next_time:238

        Kommentar


          #5
          Hm, falls du dir das zutraust: Evtl. mal den eibd in der Konsole mit t0123 starten um zu schauen, ob beim eibd alle 4 Lese-Anforderungen ankommen?

          Grüße
          Robert

          Kommentar


            #6
            Hallo Robert,

            ich kann's gerne probieren, wie lautet der genaue Befehl? Ich habe jetzt eine Weile gesucht, wie ich eibd starten muss um auch eine log Datei zu bekommen. Leider ohne Erfolg.

            Kommentar


              #7
              Am einfachsten:

              ps aux | grep eibd

              da müsste was kommen in Sinn von "usr/bin/eibd -blabla". Alles kopieren, "-D" weglassen und statt dessen -t0123. Dann hast du auch die gleichen Optionen. Vorher mit service eibd stop den eibd beenden.

              Grüße
              Robert

              Kommentar


                #8
                Hi,

                Code:
                2013-08-12 18:27:59,546 SmartHome.py DEBUG    0.0.0 read 13/3/17 -- __init__.py:parse_telegram:198
                2013-08-12 18:27:59,552 SmartHome.py DEBUG    0.0.0 read 13/3/18 -- __init__.py:parse_telegram:198
                2013-08-12 18:27:59,557 SmartHome.py DEBUG    0.0.0 read 13/3/19 -- __init__.py:parse_telegram:198
                2013-08-12 18:27:59,562 SmartHome.py DEBUG    0.0.0 read 13/3/20 -- __init__.py:parse_telegram:198
                also die vier read Requests wurde korrekt an den eibd übergeben, der sie zumindest auf der TCP-Verbindung zum KNX-Plugin weiter verschickt hat.
                Es kann sein das der eibd die Packet nicht schnell genug an den Bus los wird.
                Ich dachte er würde so etwas abpuffern. Tut er aber anscheinend nicht :-(

                Der Abstand zwischen den einzelnen Telegrammen beträgt dabei 5 bis 6 Millisekunden. Ein Read-Telegramm benötigt aber, wenn ich mich nicht verrechnet habe, 7,5 Millisekunden. => Ich müsste eine kleine Bremse in das KNX Plugin einbauen.

                Das werde ich dann mal tun. Dauert nicht lang.

                btw. wenn Du knx_init angibst, dann kannst Du Dir das knx_listen sparen.
                Weiterhin könntest Du das Problem wahrscheinlich auch dadurch umgehen in dem Du knx_cache verwendest, dann wird die Anfrage wahrscheinlich gar nicht
                auf den Bus gesendet.

                Bis gleich

                Marcus

                Kommentar


                  #9
                  Hi Guido,

                  Du kannst https://raw.github.com/mknx/smarthom...nx/__init__.py mal in plugins/knx/ kopieren und es damit probieren. Damit sollte das Problem eigentlich gelöst sein.

                  Freue mich über Feedback.

                  Bis bald

                  Marcus

                  Kommentar


                    #10
                    Hi Marcus,

                    das muss der eibd eigentlich ab können! Bei mir laufen sicher 40-50 Items per knx_cache, was ja bei einem u.U. frisch gestarteten eibd das gleiche sein sollte... Das scheint - wenn überhaupt - eher abhängig vom Typ der Schnittstelle zu sein?

                    Grüße
                    Robert

                    Kommentar


                      #11
                      Hi Robert,

                      Zitat von Robert Beitrag anzeigen
                      Das scheint - wenn überhaupt - eher abhängig vom Typ der Schnittstelle zu sein?
                      ja das klingt richtig. Er verwendet ja ein IP-Schnittstelle. Der eibd wird seine Packete wahrscheinlich schnell los, nur die IP-Schnittstelle wird wohl keinen Puffer haben.
                      Das
                      Code:
                      time.sleep(0.008)
                      sollte aber niemanden stören.

                      Bis bald

                      Marcus

                      Kommentar


                        #12
                        Hallo Marcus,

                        ich habe die Datei ersetzt, auch nach einem Neustart noch keine Änderung. Von den 4 items fehlt der Status von einem item.

                        Ich habe hier noch die Ausgabe von eibd (vor dem Austausch der Datei):

                        Code:
                        Layer 3(006B48B8,52092E99) Open
                        Layer 8(00693F30,52092E99) OpenInetSocket 6720
                        Layer 8(00693F30,52092E99) InetSocket opened
                        Layer 4(006D52C0,52092E99) GroupCacheInit
                        Layer 1(00693E50,52092E99) Send(020): 08 01 C0 A8 01 05 0E 58 08 01 C0 A8 01 05 0E 58 04 04 02 00
                        Layer 0(00693E50,52092E99) Send(026): 06 10 02 05 00 1A 08 01 C0 A8 01 05 0E 58 08 01 C0 A8 01 05 0E 58 04 04 02 00
                        Layer 0(00693E50,52092E99) Recv(020): 06 10 02 06 00 14 28 00 08 01 C0 A8 01 FE 0E 57 04 04 11 FA
                        Layer 1(00693E50,52092E99) Recv(014): 28 00 08 01 C0 A8 01 FE 0E 57 04 04 11 FA
                        Layer 8(00693F30,52092E9F) New Connection
                        Layer 8(006D5EC0,52092E9F) ClientConnection Init
                        Layer 8(006D5EC0,52092E9F) RecvMessage(002): 00 70
                        Layer 4(006D52C0,52092E9F) GroupCacheEnable
                        Layer 3(006B48B8,52092E9F) registerGroup 006D52C0
                        Layer 3(006B48B8,52092E9F) registerGroup 006D52C0 = 1
                        Layer 8(006D5EC0,52092E9F) SendMessage(002): 00 70
                        Layer 8(006D5EC0,52092E9F) RecvMessage(005): 00 26 00 00 00
                        Layer 7(006E6D2C,52092E9F) OpenGroupSocket
                        Layer 4(006D5F08,52092E9F) OpenGroupSocket RW
                        Layer 3(006B48B8,52092E9F) registerGroup 006D5F08
                        Layer 3(006B48B8,52092E9F) registerGroup 006D5F08 = 1
                        Layer 8(006D5EC0,52092E9F) SendMessage(002): 00 26
                        Layer 1(00693988,52092EB8) Heartbeat
                        Layer 1(00693E50,52092EB8) Send(010): 28 00 08 01 C0 A8 01 05 0E 58
                        Layer 0(00693E50,52092EB8) Send(016): 06 10 02 07 00 10 28 00 08 01 C0 A8 01 05 0E 58
                        Layer 0(00693E50,52092EB8) Recv(008): 06 10 02 08 00 08 28 00
                        Layer 1(00693E50,52092EB8) Recv(002): 28 00
                        Layer 7(006E6D2C,52092ED4) CloseGroupSocket
                        Layer 4(006D5F08,52092ED4) CloseGroupSocket
                        Layer 3(006B48B8,52092ED4) deregisterGroupCallBack 006D5F08 = 1
                        Layer 8(006D5EC0,52092ED4) ClientConnection closed
                        Layer 1(00693988,52092ED6) Heartbeat
                        Layer 1(00693E50,52092ED6) Send(010): 28 00 08 01 C0 A8 01 05 0E 58
                        Layer 0(00693E50,52092ED6) Send(016): 06 10 02 07 00 10 28 00 08 01 C0 A8 01 05 0E 58
                        Layer 0(00693E50,52092ED6) Recv(008): 06 10 02 08 00 08 28 00
                        Layer 1(00693E50,52092ED6) Recv(002): 28 00
                        Layer 8(00693F30,52092EDE) New Connection
                        Layer 8(006D5EE8,52092EDE) ClientConnection Init
                        Layer 8(006D5EE8,52092EDE) RecvMessage(002): 00 70
                        Layer 4(006D52C0,52092EDE) GroupCacheEnable
                        Layer 8(006D5EE8,52092EDE) SendMessage(002): 00 70
                        Layer 8(006D5EE8,52092EDE) RecvMessage(005): 00 26 00 00 00
                        Layer 7(006E6D2C,52092EDE) OpenGroupSocket
                        Layer 4(006D6418,52092EDE) OpenGroupSocket RW
                        Layer 3(006B48B8,52092EDE) registerGroup 006D6418
                        Layer 3(006B48B8,52092EDE) registerGroup 006D6418 = 1
                        Layer 8(006D5EE8,52092EDE) SendMessage(002): 00 26
                        Layer 8(006D5EE8,52092EDE) RecvMessage(006): 00 27 6B 11 00 00
                        Layer 7(006E6D2C,52092EDE) Send(002): 00 00
                        Layer 4(006D6418,52092EDE) Send GroupSocket T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 3(006B48B8,52092EDE) Send L_Data low from 0.0.0 to 13/3/17 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 2(00693988,52092EDE) Send L_Data low from 0.0.0 to 13/3/17 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 1(00693988,52092EDE) SendTunnel(015): 04 28 00 00 11 00 BC F0 00 00 6B 11 01 00 00
                        Layer 1(00693E50,52092EDE) Send(015): 04 28 00 00 11 00 BC F0 00 00 6B 11 01 00 00
                        Layer 0(00693E50,52092EDE) Send(021): 06 10 04 20 00 15 04 28 00 00 11 00 BC F0 00 00 6B 11 01 00 00
                        Layer 2(00693988,52092EDE) Recv L_Data low from 0.0.0 to 13/3/17 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 3(006B48B8,52092EDE) Recv L_Data low from 0.0.0 to 13/3/17 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 0(00693E50,52092EDE) Recv(010): 06 10 04 21 00 0A 04 28 00 00
                        Layer 4(006D6418,52092EDE) Recv GroupSocket(002): 00 00
                        Layer 7(006E6D2C,52092EDE) Recv(002): 00 00
                        Layer 8(006D5EE8,52092EDE) SendMessage(008): 00 27 00 00 6B 11 00 00
                        Layer 8(006D5EE8,52092EDE) RecvMessage(006): 00 27 6B 12 00 00
                        Layer 7(006E6D2C,52092EDE) Send(002): 00 00
                        Layer 4(006D6418,52092EDE) Send GroupSocket T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 3(006B48B8,52092EDE) Send L_Data low from 0.0.0 to 13/3/18 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 2(00693988,52092EDE) Send L_Data low from 0.0.0 to 13/3/18 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 1(00693E50,52092EDE) Recv(004): 04 28 00 00
                        Layer 0(00693E50,52092EDE) Recv(021): 06 10 04 20 00 15 04 28 00 00 2E 00 BC F0 11 FA 6B 11 01 00 00
                        Layer 1(00693988,52092EDE) SendTunnel(015): 04 28 01 00 11 00 BC F0 00 00 6B 12 01 00 00
                        Layer 1(00693E50,52092EDE) Send(015): 04 28 01 00 11 00 BC F0 00 00 6B 12 01 00 00
                        Layer 0(00693E50,52092EDE) Send(021): 06 10 04 20 00 15 04 28 01 00 11 00 BC F0 00 00 6B 12 01 00 00
                        Layer 8(006D5EE8,52092EDE) RecvMessage(006): 00 27 6B 13 00 00
                        Layer 7(006E6D2C,52092EDE) Send(002): 00 00
                        Layer 4(006D6418,52092EDE) Send GroupSocket T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 3(006B48B8,52092EDE) Send L_Data low from 0.0.0 to 13/3/19 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 2(00693988,52092EDE) Send L_Data low from 0.0.0 to 13/3/19 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 0(00693E50,52092EDE) Recv(010): 06 10 04 21 00 0A 04 28 01 00
                        Layer 2(00693988,52092EDE) Recv L_Data low from 0.0.0 to 13/3/18 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 3(006B48B8,52092EDE) Recv L_Data low from 0.0.0 to 13/3/18 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 1(00693E50,52092EDE) Recv(015): 04 28 00 00 2E 00 BC F0 11 FA 6B 11 01 00 00
                        Layer 1(00693E50,52092EDE) Send(004): 04 28 00 00
                        Layer 4(006D6418,52092EDE) Recv GroupSocket(002): 00 00
                        Layer 7(006E6D2C,52092EDE) Recv(002): 00 00
                        Layer 8(006D5EE8,52092EDE) SendMessage(008): 00 27 00 00 6B 12 00 00
                        Layer 2(00693988,52092EDE) Recv L_Data low from 0.0.0 to 13/3/19 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 3(006B48B8,52092EDE) Recv L_Data low from 0.0.0 to 13/3/19 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 0(00693E50,52092EDE) Send(010): 06 10 04 21 00 0A 04 28 00 00
                        Layer 8(006D5EE8,52092EDE) RecvMessage(006): 00 27 6B 14 00 00
                        Layer 7(006E6D2C,52092EDE) Send(002): 00 00
                        Layer 4(006D6418,52092EDE) Send GroupSocket T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 3(006B48B8,52092EDE) Send L_Data low from 0.0.0 to 13/3/20 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 2(00693988,52092EDE) Send L_Data low from 0.0.0 to 13/3/20 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 0(00693E50,52092EDE) Recv(021): 06 10 04 20 00 15 04 28 01 00 2E 00 BC F0 11 FA 6B 12 01 00 00
                        Layer 4(006D6418,52092EDE) Recv GroupSocket(002): 00 00
                        Layer 7(006E6D2C,52092EDE) Recv(002): 00 00
                        Layer 8(006D5EE8,52092EDE) SendMessage(008): 00 27 00 00 6B 13 00 00
                        Layer 1(00693E50,52092EDE) Recv(004): 04 28 01 00
                        Layer 1(00693988,52092EDE) SendTunnel(015): 04 28 02 00 11 00 BC F0 00 00 6B 13 01 00 00
                        Layer 1(00693E50,52092EDE) Send(015): 04 28 02 00 11 00 BC F0 00 00 6B 13 01 00 00
                        Layer 2(00693988,52092EDE) Recv L_Data low from 0.0.0 to 13/3/20 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 3(006B48B8,52092EDE) Recv L_Data low from 0.0.0 to 13/3/20 hops: 07 T_DATA_XXX_REQ A_GroupValue_Read
                        Layer 0(00693E50,52092EDE) Send(021): 06 10 04 20 00 15 04 28 02 00 11 00 BC F0 00 00 6B 13 01 00 00
                        Layer 4(006D6418,52092EDE) Recv GroupSocket(002): 00 00
                        Layer 7(006E6D2C,52092EDE) Recv(002): 00 00
                        Layer 8(006D5EE8,52092EDE) SendMessage(008): 00 27 00 00 6B 14 00 00
                        Layer 1(00693E50,52092EDE) Recv(015): 04 28 01 00 2E 00 BC F0 11 FA 6B 12 01 00 00
                        Layer 1(00693E50,52092EDE) Send(004): 04 28 01 00
                        Layer 0(00693E50,52092EDE) Recv(010): 06 10 04 21 00 0A 04 28 02 00
                        Layer 0(00693E50,52092EDE) Send(010): 06 10 04 21 00 0A 04 28 01 00
                        Layer 1(00693E50,52092EDE) Recv(004): 04 28 02 00
                        Layer 1(00693988,52092EDE) SendTunnel(015): 04 28 03 00 11 00 BC F0 00 00 6B 14 01 00 00
                        Layer 1(00693E50,52092EDE) Send(015): 04 28 03 00 11 00 BC F0 00 00 6B 14 01 00 00
                        Layer 0(00693E50,52092EDE) Send(021): 06 10 04 20 00 15 04 28 03 00 11 00 BC F0 00 00 6B 14 01 00 00
                        Layer 0(00693E50,52092EDE) Recv(021): 06 10 04 20 00 15 04 28 02 00 29 00 BC F0 11 32 6B 11 01 00 40
                        Layer 1(00693E50,52092EDE) Recv(015): 04 28 02 00 29 00 BC F0 11 32 6B 11 01 00 40
                        Layer 1(00693E50,52092EDE) Send(004): 04 28 02 00
                        Layer 0(00693E50,52092EDE) Recv(010): 06 10 04 21 00 0A 04 28 03 00
                        Layer 1(00693988,52092EDE) Recv L_Data low from 1.1.50 to 13/3/17 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 0(00693E50,52092EDE) Send(010): 06 10 04 21 00 0A 04 28 02 00
                        Layer 2(00693988,52092EDE) Recv L_Data low from 1.1.50 to 13/3/17 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 3(006B48B8,52092EDE) Recv L_Data low from 1.1.50 to 13/3/17 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 1(00693E50,52092EDE) Recv(004): 04 28 03 00
                        Layer 4(006D6418,52092EDE) Recv GroupSocket(002): 00 40
                        Layer 7(006E6D2C,52092EDE) Recv(002): 00 40
                        Layer 8(006D5EE8,52092EDE) SendMessage(008): 00 27 11 32 6B 11 00 40
                        Layer 0(00693E50,52092EDE) Recv(021): 06 10 04 20 00 15 04 28 03 00 2E 00 BC F0 11 FA 6B 13 01 00 00
                        Layer 1(00693E50,52092EDE) Recv(015): 04 28 03 00 2E 00 BC F0 11 FA 6B 13 01 00 00
                        Layer 1(00693E50,52092EDE) Send(004): 04 28 03 00
                        Layer 0(00693E50,52092EDE) Send(010): 06 10 04 21 00 0A 04 28 03 00
                        Layer 0(00693E50,52092EDE) Recv(021): 06 10 04 20 00 15 04 28 04 00 29 00 BC F0 11 32 6B 12 01 00 40
                        Layer 1(00693E50,52092EDE) Recv(015): 04 28 04 00 29 00 BC F0 11 32 6B 12 01 00 40
                        Layer 1(00693E50,52092EDE) Send(004): 04 28 04 00
                        Layer 0(00693E50,52092EDE) Send(010): 06 10 04 21 00 0A 04 28 04 00
                        Layer 1(00693988,52092EDE) Recv L_Data low from 1.1.50 to 13/3/18 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 2(00693988,52092EDE) Recv L_Data low from 1.1.50 to 13/3/18 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 3(006B48B8,52092EDE) Recv L_Data low from 1.1.50 to 13/3/18 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 4(006D6418,52092EDE) Recv GroupSocket(002): 00 40
                        Layer 7(006E6D2C,52092EDE) Recv(002): 00 40
                        Layer 8(006D5EE8,52092EDE) SendMessage(008): 00 27 11 32 6B 12 00 40
                        Layer 0(00693E50,52092EDE) Recv(021): 06 10 04 20 00 15 04 28 05 00 2E 00 BC F0 11 FA 6B 14 01 00 00
                        Layer 1(00693E50,52092EDE) Recv(015): 04 28 05 00 2E 00 BC F0 11 FA 6B 14 01 00 00
                        Layer 1(00693E50,52092EDE) Send(004): 04 28 05 00
                        Layer 0(00693E50,52092EDE) Send(010): 06 10 04 21 00 0A 04 28 05 00
                        Layer 0(00693E50,52092EDE) Recv(021): 06 10 04 20 00 15 04 28 06 00 29 00 BC F0 11 32 6B 13 01 00 40
                        Layer 1(00693E50,52092EDE) Recv(015): 04 28 06 00 29 00 BC F0 11 32 6B 13 01 00 40
                        Layer 1(00693E50,52092EDE) Send(004): 04 28 06 00
                        Layer 0(00693E50,52092EDE) Send(010): 06 10 04 21 00 0A 04 28 06 00
                        Layer 1(00693988,52092EDE) Recv L_Data low from 1.1.50 to 13/3/19 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 2(00693988,52092EDE) Recv L_Data low from 1.1.50 to 13/3/19 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 3(006B48B8,52092EDE) Recv L_Data low from 1.1.50 to 13/3/19 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 4(006D6418,52092EDE) Recv GroupSocket(002): 00 40
                        Layer 7(006E6D2C,52092EDE) Recv(002): 00 40
                        Layer 8(006D5EE8,52092EDE) SendMessage(008): 00 27 11 32 6B 13 00 40
                        Layer 0(00693E50,52092EDE) Recv(021): 06 10 04 20 00 15 04 28 07 00 29 00 BC F0 11 32 6B 14 01 00 40
                        Layer 1(00693E50,52092EDE) Recv(015): 04 28 07 00 29 00 BC F0 11 32 6B 14 01 00 40
                        Layer 1(00693E50,52092EDE) Send(004): 04 28 07 00
                        Layer 0(00693E50,52092EDE) Send(010): 06 10 04 21 00 0A 04 28 07 00
                        Layer 1(00693988,52092EDE) Recv L_Data low from 1.1.50 to 13/3/20 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 2(00693988,52092EDE) Recv L_Data low from 1.1.50 to 13/3/20 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 3(006B48B8,52092EDE) Recv L_Data low from 1.1.50 to 13/3/20 hops: 07 T_DATA_XXX_REQ A_GroupValue_Response (small) 00
                        Layer 4(006D6418,52092EDE) Recv GroupSocket(002): 00 40
                        Layer 7(006E6D2C,52092EDE) Recv(002): 00 40
                        Layer 8(006D5EE8,52092EDE) SendMessage(008): 00 27 11 32 6B 14 00 40

                        Kommentar


                          #13
                          Hi Guido,

                          für mich sieht das so aus als ob der eibd die replies sehr wohl erhält (von der PA 1.1.50), diese kommen aber irgendwie nicht beim KNX Plugin an.

                          In der knx/plugin/__init__.py steht in Zeile 166
                          Code:
                          #           logger.debug("Ignore telegram.")
                          kannst Du das '#' bitte mit einem ' ' ersetzen und es noch mal probieren?
                          Und das Debuglog posten?

                          Danke

                          Marcus

                          P.S. auch für Dich gilt knx_send != knx_listen/init/cache. Man sollte immer zwischen Schalt-GA und Status-GA differenzieren.

                          Kommentar


                            #14
                            Ich habe smarthome.py das 1. mal mit '-n' neu gestartet. Der Status von allen 4 items war korrekt. Mit '--stop' + 'start' neu gestartet fehlte wieder ein Status. Beim zweiten mal Starten mit '-n' fehlte auch ein Status.

                            Hier der DebugLog vom zweiten Start mit '-n':

                            Code:
                            2013-08-12 21:36:58,381 SmartHome.py INFO     Start SmartHome.py 0.9-10-g63eb637+ -- smarthome.py:__init__:192
                            2013-08-12 21:36:58,386 SmartHome.py DEBUG    Python 2.7.3 -- smarthome.py:__init__:193
                            2013-08-12 21:36:58,393 SmartHome.py INFO     Init Scheduler -- scheduler.py:__init__:53
                            2013-08-12 21:36:58,398 SmartHome.py INFO     Init Plugins -- smarthome.py:__init__:208
                            2013-08-12 21:36:58,408 Scheduler    DEBUG    creating 5 workers -- scheduler.py:run:59
                            2013-08-12 21:36:58,421 SmartHome.py DEBUG    Plugin: knx -- plugin.py:__init__:42
                            2013-08-12 21:36:58,463 SmartHome.py DEBUG    Plugin: ow -- plugin.py:__init__:42
                            2013-08-12 21:36:58,479 SmartHome.py ERROR    Onewire: could not connect to 127.0.0.1:4304: [Errno 111] Connection refused -- __init__.py:connect:62
                            2013-08-12 21:36:58,485 SmartHome.py DEBUG    Plugin: cli -- plugin.py:__init__:42
                            2013-08-12 21:36:58,497 SmartHome.py DEBUG    Plugin: visu -- plugin.py:__init__:42
                            2013-08-12 21:36:58,581 SmartHome.py DEBUG    Plugin: sql -- plugin.py:__init__:42
                            2013-08-12 21:36:58,606 SmartHome.py DEBUG    SQLite 3.7.13 -- __init__.py:__init__:60
                            2013-08-12 21:36:58,633 SmartHome.py DEBUG    sqlite next time: 2013-08-13 03:02:00+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:36:58,637 SmartHome.py DEBUG    Plugin: rrd -- plugin.py:__init__:42
                            2013-08-12 21:36:58,735 SmartHome.py INFO     Init Items -- smarthome.py:__init__:210
                            2013-08-12 21:36:58,916 SmartHome.py DEBUG    knx: second.sleeping.light.level listen on 3/2/14 -- __init__.py:parse_item:243
                            2013-08-12 21:36:58,921 SmartHome.py DEBUG    knx: Light listen on 3/2/12 -- __init__.py:parse_item:243
                            2013-08-12 21:36:59,045 SmartHome.py DEBUG    knx: room1.bel1 listen on 13/3/17 -- __init__.py:parse_item:243
                            2013-08-12 21:36:59,049 SmartHome.py DEBUG    knx: room1.bel1 listen on and init with 13/3/17 -- __init__.py:parse_item:252
                            2013-08-12 21:36:59,057 SmartHome.py DEBUG    knx: room1.bel2 listen on 13/3/18 -- __init__.py:parse_item:243
                            2013-08-12 21:36:59,061 SmartHome.py DEBUG    knx: room1.bel2 listen on and init with 13/3/18 -- __init__.py:parse_item:252
                            2013-08-12 21:36:59,070 SmartHome.py DEBUG    knx: room1.bel3 listen on 13/3/19 -- __init__.py:parse_item:243
                            2013-08-12 21:36:59,073 SmartHome.py DEBUG    knx: room1.bel3 listen on and init with 13/3/19 -- __init__.py:parse_item:252
                            2013-08-12 21:36:59,082 SmartHome.py DEBUG    knx: room1.bel4 listen on 13/3/20 -- __init__.py:parse_item:243
                            2013-08-12 21:36:59,086 SmartHome.py DEBUG    knx: room1.bel4 listen on and init with 13/3/20 -- __init__.py:parse_item:252
                            2013-08-12 21:36:59,208 SmartHome.py INFO     Start Plugins -- plugin.py:start:63
                            2013-08-12 21:36:59,218 ow           DEBUG    1w-disc next time: 2013-08-12 21:36:59+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:36:59,238 SmartHome.py INFO     Start Logics -- logic.py:__init__:32
                            2013-08-12 21:36:59,242 SmartHome.py DEBUG    reading logics from /usr/smarthome/etc/logic.conf -- logic.py:__init__:38
                            2013-08-12 21:36:59,266 rrd          DEBUG    rrd next time: 2013-08-12 21:38:39+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:36:59,263 SmartHome.py DEBUG    Logic: hello -- logic.py:__init__:45
                            2013-08-12 21:36:59,320 SmartHome.py DEBUG    Logic: dummy -- logic.py:__init__:45
                            2013-08-12 21:36:59,332 SmartHome.py DEBUG    dummy next time: 2013-08-12 21:37:11+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:36:59,386 sh.con       DEBUG    knx: enable group monitor -- __init__.py:handle_connect:119
                            2013-08-12 21:36:59,398 visu         DEBUG    series next time: 2013-08-12 21:37:09+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:36:59,406 sh.con       DEBUG    knx: init read -- __init__.py:handle_connect:125
                            2013-08-12 21:36:59,452 sh.con       INFO     KNX: connected to 127.0.0.1:6720 -- my_asynchat.py:connect:69
                            2013-08-12 21:36:59,555 Scheduler    DEBUG    1w-disc next time: 2013-08-12 21:46:59+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:36:59,643 sh.gc        DEBUG    Garbage collector: collected 907 objects. -- smarthome.py:_garbage_collection:345
                            2013-08-12 21:36:59,782 Scheduler    DEBUG    sh.gc next time: 2013-08-13 02:04:00+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:37:00,357 SmartHome.py DEBUG    Ignore telegram. -- __init__.py:parse_telegram:166
                            2013-08-12 21:37:00,361 SmartHome.py DEBUG    Ignore telegram. -- __init__.py:parse_telegram:166
                            2013-08-12 21:37:00,366 SmartHome.py DEBUG    0.0.0 read 13/3/17 -- __init__.py:parse_telegram:211
                            2013-08-12 21:37:00,371 SmartHome.py DEBUG    0.0.0 read 13/3/18 -- __init__.py:parse_telegram:211
                            2013-08-12 21:37:00,375 SmartHome.py DEBUG    0.0.0 read 13/3/19 -- __init__.py:parse_telegram:211
                            2013-08-12 21:37:00,380 SmartHome.py DEBUG    0.0.0 read 13/3/20 -- __init__.py:parse_telegram:211
                            2013-08-12 21:37:00,385 SmartHome.py DEBUG    knx: 1.1.50 set 13/3/17 to True -- __init__.py:parse_telegram:198
                            2013-08-12 21:37:00,391 SmartHome.py DEBUG    room1.bel1 = True via KNX 1.1.50 -- item.py:_update:219
                            2013-08-12 21:37:00,399 SmartHome.py DEBUG    knx: 1.1.50 set 13/3/18 to True -- __init__.py:parse_telegram:198
                            2013-08-12 21:37:00,404 SmartHome.py DEBUG    room1.bel2 = True via KNX 1.1.50 -- item.py:_update:219
                            2013-08-12 21:37:00,411 SmartHome.py DEBUG    knx: 1.1.50 set 13/3/20 to True -- __init__.py:parse_telegram:198
                            2013-08-12 21:37:00,416 SmartHome.py DEBUG    room1.bel4 = True via KNX 1.1.50 -- item.py:_update:219
                            2013-08-12 21:37:03,018 hello        INFO     Hello World! -- hello.py:<module>:3
                            2013-08-12 21:37:09,273 Scheduler    DEBUG    series next time: 2013-08-12 21:37:19+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:37:11,138 dummy        DEBUG    first.living.humidity = 51 via Logic None -- item.py:_update:219
                            2013-08-12 21:37:11,301 Scheduler    DEBUG    dummy next time: 2013-08-12 21:42:11+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:37:13,129 dummy        DEBUG    second.sleeping.temperature = 21 via Logic None -- item.py:_update:219
                            2013-08-12 21:37:17,977 dummy        DEBUG    second.bath.temperature = 22 via Logic None -- item.py:_update:219
                            2013-08-12 21:37:19,382 Scheduler    DEBUG    series next time: 2013-08-12 21:37:29+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:37:22,120 SmartHome.py INFO     WebSocket: incoming connection from 192.168.1.32:56186 -- __init__.py:handle_accept:115
                            2013-08-12 21:37:22,391 SmartHome.py DEBUG    192.168.1.32:56186 sent '{"cmd":"proto","ver":2}' -- __init__.py:json_parse:257
                            2013-08-12 21:37:25,667 SmartHome.py DEBUG    192.168.1.32:56186 sent '{"cmd":"monitor","items":["room1.bel1","room1.bel2","room1.bel3","room1.bel4"]}' -- __init__.py:json_parse:257
                            2013-08-12 21:37:29,287 Scheduler    DEBUG    series next time: 2013-08-12 21:37:39+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:37:39,388 Scheduler    DEBUG    series next time: 2013-08-12 21:37:49+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:37:49,285 Scheduler    DEBUG    series next time: 2013-08-12 21:37:59+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:37:57,367 SmartHome.py DEBUG    WebSocket: closing connection to 192.168.1.32:56186. -- __init__.py:rfc6455_parse:380
                            2013-08-12 21:37:59,241 Scheduler    DEBUG    series next time: 2013-08-12 21:38:09+02:00 -- scheduler.py:_next_time:238
                            2013-08-12 21:38:09,341 Scheduler    DEBUG    series next time: 2013-08-12 21:38:19+02:00 -- scheduler.py:_next_time:238

                            Kommentar


                              #15
                              Hi,

                              kannst Du bitte das 'logger.debug("Ignore telegram.")' mit
                              Code:
                              logger.debug("typ: {0}, len: {1}, telegram: {2}".format(typ, len(telegram), self.decode(telegram, 'hex')))
                              erstetzen und noch mal das Log posten?

                              Danke

                              Marcus

                              Kommentar

                              Lädt...
                              X