WARNING: Unknown module: io.calimero.serial.provider.rxtx specified to --add-reads
13:40:01.385 [TRACE ] io.calimero.xml.XmlResolver: resolve server-config.xml
13:40:01.394 [TRACE ] io.calimero.xml.XmlInputFactory: no StaX implementation found (java.lang.NoClassDefFoundError: javax/xml/stream/XMLStreamException), using internal XMLStreamReader
13:40:02.204 [TRACE ] io.calimero.xml.XmlResolver: resolve jar:file:///usr/app/calimero-server-3.0-SNAPSHOT/lib/calimero-core-3.0-SNAPSHOT.jar!/properties.xml
13:40:02.224 [TRACE ] io.calimero.xml.XmlInputFactory: no StaX implementation found (java.lang.NoClassDefFoundError: javax/xml/stream/XMLStreamException), using internal XMLStreamReader
13:40:02.722 [DEBUG ] io.calimero.device.knx-server: loading interface object server from file:///usr/app/knx-server-ios.xml
13:40:02.731 [TRACE ] io.calimero.xml.XmlResolver: resolve file:///usr/app/knx-server-ios.xml
13:40:02.737 [DEBUG ] io.calimero.device.knx-server: no interface object server resource, create resource on closing device: /usr/app/knx-server-ios.xml (No such file or directory)
13:40:02.998 [INFO ] io.calimero.server.knx-server: Calimero KNX IP server v3.0-SNAPSHOT
13:40:03.172 [INFO ] io.calimero.server.knx-server: use configuration 'Calimero KNX' with 1 service container, discovery: listen on [eth0] send on [eth0] interfaces
service container /dev/ttyAMA0:
server: listen on eth0 (port 3671), KNX IP routing multicast group 224.0.23.12
Tpuart /dev/ttyAMA0 connection: TP1 medium, device 6.6.0
13:40:03.241 [DEBUG ] io.calimero.server.knx-server: setup Tpuart subnet {1}
13:40:03.326 [INFO ] io.calimero.server.gateway.knx-server: activate '/dev/ttyAMA0' disruption buffer on ports [5,555-5,559], disruption timeout 30 s
13:40:03.346 [TRACE ] io.calimero.device.knx-server: sync Addresstable Object from address 0x116
13:40:03.350 [TRACE ] io.calimero.device.knx-server: sync Associationtable Object from address 0x1000
13:40:03.354 [TRACE ] io.calimero.device.knx-server: sync Group Object Table Object from address 0x3000
type 'stop' to stop the gateway and shutdown the server
13:40:03.629 [TRACE ] io.calimero.server.knx-server: network stack uses IPv4 addresses: unknown
13:40:03.732 [TRACE ] io.calimero.server.knx-server: found network interfaces eth0 [192.168.31.22]
13:40:03.738 [INFO ] io.calimero.server.knx-server: discovery endpoint [eth0] is up and running
13:40:03.748 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 control endpoint bound to 192.168.31.22:3671
13:40:03.760 [DEBUG ] io.calimero.knxnetip.KNXnet/IP Routing 224.0.23.12:3671: join multicast group 224.0.23.12 on eth0
13:40:03.763 [TRACE ] io.calimero.serial.ConnectionFactory: instantiate service provider io.calimero.serial.provider.jni.TtySerialComProvider
13:40:03.764 [INFO ] io.calimero.knxnetip.KNXnet/IP Routing 224.0.23.12:3671: multicast loopback mode enabled
13:40:03.779 [TRACE ] io.calimero.serial.provider.jni: check Java library path /usr/java/packages/lib:/lib:/usr/lib
13:40:03.786 [DEBUG ] io.calimero.serial.provider.jni: opening serial port /dev/ttyAMA0
13:40:03.793 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 KNX IP routing service (eth0 224.0.23.12) is up and running
13:40:03.846 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 secure mgmt/tunneling connections: optional/optional
13:40:03.890 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 tcp service (eth0 192.168.31.22:3671) is up and running
13:40:03.897 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 control endpoint (eth0 192.168.31.22:3671) is up and running
13:40:03.922 [DEBUG ] io.calimero.serial.ConnectionFactory: io.calimero.serial.provider.jni.TtySerialComProvider@97bbb8 port setup: baudrate 19200, even parity, 8 databits, 1 stopbits, timeouts: read 0 read total 0 constant 100 write total 0 write constant 0
13:40:03.943 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: drained rx queue (0 bytes)
13:40:03.947 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: reset TP-UART controller
13:40:03.952 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART reset.ind
13:40:03.958 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 2,376 us
13:40:03.962 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: wait for initial TP-UART state
13:40:03.972 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:03.977 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 343 us
13:40:03.986 [DEBUG ] io.calimero.link.tpuart:/dev/ttyAMA0: hop count set to 6
13:40:03.996 [DEBUG ] io.calimero.server.gateway.knx-server: set maximum APDU length of '/dev/ttyAMA0' to 15
13:40:04.090 [DEBUG ] io.calimero.event: unsupported event type void io.calimero.server.gateway.KnxServerGateway$SubnetListener.connectionStatus(io.calimero.serial.ConnectionStatus)
13:40:04.094 [DEBUG ] io.calimero.event: unsupported event type void io.calimero.server.gateway.KnxServerGateway$SubnetListener.baosService(io.calimero.baos.BaosService)
13:40:04.962 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:48864 on [any]
13:40:04.971 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:48864 on [any]
13:40:07.419 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 02 05 00 1a 08 01 00 00 00 00 00 00 08 01 00 00 00 00 00 00 04 04 02 00
13:40:07.429 [DEBUG ] io.calimero.server.knx-server: responses to client use route-back control endpoint 192.168.31.101:5559
13:40:07.433 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0: setup data endpoint (UDP NAT, channel 1) for connection request from 192.168.31.101:5559
13:40:07.436 [DEBUG ] io.calimero.server.knx-server: responses use route-back data endpoint 192.168.31.101:5559
13:40:07.457 [INFO ] io.calimero.server.knx-server: assign additional individual address 6.6.2 to channel 1
13:40:07.462 [DEBUG ] io.calimero.server.knx-server: created socket on 192.168.31.22:35069
13:40:07.550 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 data endpoint KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2) is up and running
13:40:07.556 [DEBUG ] io.calimero.server.gateway.knx-server: established connection KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2)
13:40:07.560 [DEBUG ] io.calimero.server.gateway.ReplayBuffer: activate replay buffer for KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2)
13:40:07.649 [INFO ] io.calimero.server.gateway.ReplayBuffer: match for Key[hostAddress=192.168.31.101, port=5559, timestamp=1713015607563] in open connections with missing events: []
13:40:07.653 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 02 07 00 10 01 00 08 01 00 00 00 00 00 00
13:40:07.659 [TRACE ] io.calimero.server.knx-server: received connection-state request (channel 1) from 192.168.31.101:5559
13:40:08.632 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:20029 on [any]
13:40:08.641 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:20029 on [any]
13:40:09.002 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,029,492 us
13:40:09.006 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:09.009 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 2,817 us
13:40:10.426 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 04 20 00 15 04 01 00 00 11 00 bc e0 66 d3 32 01 01 00 00
13:40:10.445 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 04 21 00 0a 04 01 00 00
13:40:10.462 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 04 20 00 15 04 01 01 00 11 00 bc e0 66 d3 31 01 01 00 81
13:40:10.466 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 04 21 00 0a 04 01 01 00
13:40:10.471 [TRACE ] io.calimero.server.gateway.knx-server: server-side KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2): 6.6.211->6/2/1 L_Data.req, low priority hop count 6 repeat, tpdu 00 00: T_Group, A_Group.read
13:40:10.480 [TRACE ] io.calimero.server.gateway.knx-server: send positive cEMI L_Data.con
13:40:10.490 [DEBUG ] io.calimero.server.gateway.knx-server: dispatch 6.6.211->6/2/1 using KNX IP routing service (eth0 224.0.23.12)
13:40:10.499 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): add to multicast loopback frame buffer: 6.6.211->6/2/1 L_Data.ind, low priority hop count 6, tpdu 00 00
13:40:10.510 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): sending cEMI frame seq 0, NonBlocking, attempt 1 (channel 0) 06 10 05 30 00 11 29 00 bc e0 66 d3 32 01 01 00 00
13:40:10.515 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: sending cEMI frame seq 0, WaitForAck, attempt 1 (channel 1) 06 10 04 20 00 15 04 01 00 00 2e 00 bc e0 66 d3 32 01 01 00 00
13:40:10.517 [TRACE ] io.calimero.server.gateway.knx-server: forward 6.6.211->6/2/1 L_Data.req, low priority hop count 6 repeat, tpdu 00 00 to all tunneling clients (except 6.6.211)
13:40:10.518 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): discard multicast loopback cEMI frame: 6.6.211->6/2/1 L_Data.ind, low priority hop count 6, tpdu 00 00
13:40:10.518 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 04 20 00 15 04 01 00 00 2e 00 bc e0 66 d3 32 01 01 00 00
13:40:10.523 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): add to multicast loopback frame buffer: 6.6.211->6/2/1 L_Data.ind, low priority hop count 6, tpdu 00 00
13:40:10.528 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 04 21 00 0a 04 01 00 00
13:40:10.528 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): sending cEMI frame seq 0, NonBlocking, attempt 1 (channel 0) 06 10 05 30 00 11 29 00 bc e0 66 d3 32 01 01 00 00
13:40:10.533 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): discard multicast loopback cEMI frame: 6.6.211->6/2/1 L_Data.ind, low priority hop count 6, tpdu 00 00
13:40:10.534 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: received service ack 0 from 192.168.31.101:5559 (channel 1)
13:40:10.542 [TRACE ] io.calimero.server.gateway.knx-server: dispatch to subnet /dev/ttyAMA0: 6.6.211->6/2/1 L_Data.req, low priority hop count 5 repeat, tpdu 00 00
13:40:10.544 [DEBUG ] io.calimero.link.tpuart:/dev/ttyAMA0: send (wait for confirmation) 6.6.211->6/2/1 L_Data.req, low priority hop count 5 repeat, tpdu 00 00
13:40:10.550 [TRACE ] io.calimero.link.tpuart:/dev/ttyAMA0: send cEMI 11 00 bc d0 66 d3 32 01 01 00 00
13:40:10.555 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: create UART services 80 bc 81 66 82 d3 83 32 84 01 85 d1 86 00 87 00 48 14
13:40:10.558 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: write UART services, waiting for .con
13:40:10.582 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 1,577,458 us
13:40:10.612 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: write ACK (0x11) for 6/2/1
13:40:10.615 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: finished reading 5 bytes after 299 us
13:40:10.619 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 30,000 us
13:40:10.623 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: reset receive buffer after 29,581 us, char 0x0, discard partial frame (length 6) bc 66 d3 32 01 d1
13:40:10.626 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 351 us
13:40:10.629 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 48 us
13:40:10.633 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: finished reading 6 bytes after 1,757 us
13:40:10.636 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 1,948 us
13:40:10.640 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 82 us
13:40:10.643 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 51 us
13:40:10.646 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: received TP1 L-Data (length 10): 14 8b bc 11 04 32 01 e1 00 40
13:40:10.649 [ERROR ] io.calimero.serial.tpuart:/dev/ttyAMA0: error creating L-Data from TP1 data (length 14 8b bc 11 04 32 01 e1 00 40): java.lang.IllegalArgumentException: fromIndex(0) > toIndex(-2)
13:40:10.652 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 937 us
13:40:10.655 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 1,584 us
13:40:10.661 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: write ACK (0x11) for 6/2/1
13:40:10.665 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: finished reading 5 bytes after 211 us
13:40:10.668 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 34,243 us
13:40:10.673 [WARNING] io.calimero.server.gateway.knx-server: timeout sending to 6/2/1: no ACK for L-Data.con
13:40:10.672 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: reset receive buffer after 30,358 us, char 0x0, discard partial frame (length 6) 9c 11 04 32 01 e1
13:40:10.676 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 385 us
13:40:10.676 [TRACE ] io.calimero.server.gateway.knx-server: server-side KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2): 6.6.211->6/1/1 L_Data.req, low priority hop count 6 repeat, tpdu 00 81: T_Group, A_Group.write
13:40:10.680 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 51 us
13:40:10.681 [TRACE ] io.calimero.server.gateway.knx-server: send positive cEMI L_Data.con
13:40:10.683 [DEBUG ] io.calimero.server.gateway.knx-server: dispatch 6.6.211->6/1/1 using KNX IP routing service (eth0 224.0.23.12)
13:40:10.683 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 39 us
13:40:10.685 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): add to multicast loopback frame buffer: 6.6.211->6/1/1 L_Data.ind, low priority hop count 6, tpdu 00 81
13:40:10.686 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: no ACK received after 83 ms
13:40:10.687 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: sending cEMI frame seq 1, WaitForAck, attempt 1 (channel 1) 06 10 04 20 00 15 04 01 01 00 2e 00 bc e0 66 d3 31 01 01 00 81
13:40:10.691 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 04 20 00 15 04 01 01 00 2e 00 bc e0 66 d3 31 01 01 00 81
13:40:10.691 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): sending cEMI frame seq 0, NonBlocking, attempt 1 (channel 0) 06 10 05 30 00 11 29 00 bc e0 66 d3 31 01 01 00 81
13:40:10.696 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): discard multicast loopback cEMI frame: 6.6.211->6/1/1 L_Data.ind, low priority hop count 6, tpdu 00 81
13:40:10.699 [TRACE ] io.calimero.server.gateway.knx-server: forward 6.6.211->6/1/1 L_Data.req, low priority hop count 6 repeat, tpdu 00 81 to all tunneling clients (except 6.6.211)
13:40:10.702 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): add to multicast loopback frame buffer: 6.6.211->6/1/1 L_Data.ind, low priority hop count 6, tpdu 00 81
13:40:10.702 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 04 21 00 0a 04 01 01 00
13:40:10.707 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: received service ack 1 from 192.168.31.101:5559 (channel 1)
13:40:10.707 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): sending cEMI frame seq 0, NonBlocking, attempt 1 (channel 0) 06 10 05 30 00 11 29 00 bc e0 66 d3 31 01 01 00 81
13:40:10.712 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): discard multicast loopback cEMI frame: 6.6.211->6/1/1 L_Data.ind, low priority hop count 6, tpdu 00 81
13:40:10.712 [TRACE ] io.calimero.server.gateway.knx-server: dispatch to subnet /dev/ttyAMA0: 6.6.211->6/1/1 L_Data.req, low priority hop count 5 repeat, tpdu 00 81
13:40:10.716 [DEBUG ] io.calimero.link.tpuart:/dev/ttyAMA0: send (wait for confirmation) 6.6.211->6/1/1 L_Data.req, low priority hop count 5 repeat, tpdu 00 81
13:40:10.719 [TRACE ] io.calimero.link.tpuart:/dev/ttyAMA0: send cEMI 11 00 bc d0 66 d3 31 01 01 00 81
13:40:10.722 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: create UART services 80 bc 81 66 82 d3 83 31 84 01 85 d1 86 00 87 81 48 96
13:40:10.725 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: write UART services, waiting for .con
13:40:10.781 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: write ACK (0x11) for 6/1/1
13:40:10.786 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: finished reading 5 bytes after 77 us
13:40:10.789 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 30,049 us
13:40:10.789 [DEBUG ] io.calimero.link.tpuart:/dev/ttyAMA0: confirmation of 6/1/1
13:40:10.793 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: reset receive buffer after 29,960 us, char 0x0, discard partial frame (length 6) bc 66 d3 31 01 d1
13:40:10.796 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 190 us
13:40:10.799 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 41 us
13:40:10.803 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 39 us
13:40:10.805 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: positive L_Data.con
13:40:10.808 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: ACK received after 30 ms
13:40:10.812 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: cEMI (length 11): 2e 00 bc d0 66 d3 31 01 01 00 81
13:40:10.815 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 10,528 us
13:40:10.912 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: write ACK (0x11) for 6/2/1
13:40:10.915 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: finished reading 5 bytes after 78 us
13:40:10.919 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 26,519 us
13:40:10.923 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: reset receive buffer after 22,627 us, char 0x0, discard partial frame (length 6) bc 11 04 32 01 e1
13:40:10.927 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 192 us
13:40:10.931 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 41 us
13:40:10.934 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 38 us
13:40:12.390 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:39522 on [any]
13:40:12.398 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:39522 on [any]
13:40:14.032 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 3,119,394 us
13:40:14.035 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:14.038 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 307 us
13:40:15.435 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 04 20 00 15 04 01 02 00 11 00 bc e0 66 d3 31 01 01 00 80
13:40:15.439 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 04 21 00 0a 04 01 02 00
13:40:15.445 [TRACE ] io.calimero.server.gateway.knx-server: server-side KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2): 6.6.211->6/1/1 L_Data.req, low priority hop count 6 repeat, tpdu 00 80: T_Group, A_Group.write
13:40:15.446 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 04 20 00 15 04 01 03 00 11 00 bc e0 66 d3 32 01 01 00 80
13:40:15.449 [TRACE ] io.calimero.server.gateway.knx-server: send positive cEMI L_Data.con
13:40:15.449 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 04 21 00 0a 04 01 03 00
13:40:15.451 [DEBUG ] io.calimero.server.gateway.knx-server: dispatch 6.6.211->6/1/1 using KNX IP routing service (eth0 224.0.23.12)
13:40:15.454 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): add to multicast loopback frame buffer: 6.6.211->6/1/1 L_Data.ind, low priority hop count 6, tpdu 00 80
13:40:15.456 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: sending cEMI frame seq 2, WaitForAck, attempt 1 (channel 1) 06 10 04 20 00 15 04 01 02 00 2e 00 bc e0 66 d3 31 01 01 00 80
13:40:15.458 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): sending cEMI frame seq 0, NonBlocking, attempt 1 (channel 0) 06 10 05 30 00 11 29 00 bc e0 66 d3 31 01 01 00 80
13:40:15.461 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 04 20 00 15 04 01 02 00 2e 00 bc e0 66 d3 31 01 01 00 80
13:40:15.462 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): discard multicast loopback cEMI frame: 6.6.211->6/1/1 L_Data.ind, low priority hop count 6, tpdu 00 80
13:40:15.463 [TRACE ] io.calimero.server.gateway.knx-server: forward 6.6.211->6/1/1 L_Data.req, low priority hop count 6 repeat, tpdu 00 80 to all tunneling clients (except 6.6.211)
13:40:15.467 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): add to multicast loopback frame buffer: 6.6.211->6/1/1 L_Data.ind, low priority hop count 6, tpdu 00 80
13:40:15.471 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): sending cEMI frame seq 0, NonBlocking, attempt 1 (channel 0) 06 10 05 30 00 11 29 00 bc e0 66 d3 31 01 01 00 80
13:40:15.475 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 04 21 00 0a 04 01 02 00
13:40:15.475 [TRACE ] io.calimero.server.gateway.knx-server: dispatch to subnet /dev/ttyAMA0: 6.6.211->6/1/1 L_Data.req, low priority hop count 5 repeat, tpdu 00 80
13:40:15.475 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): discard multicast loopback cEMI frame: 6.6.211->6/1/1 L_Data.ind, low priority hop count 6, tpdu 00 80
13:40:15.480 [DEBUG ] io.calimero.link.tpuart:/dev/ttyAMA0: send (wait for confirmation) 6.6.211->6/1/1 L_Data.req, low priority hop count 5 repeat, tpdu 00 80
13:40:15.480 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: received service ack 2 from 192.168.31.101:5559 (channel 1)
13:40:15.483 [TRACE ] io.calimero.link.tpuart:/dev/ttyAMA0: send cEMI 11 00 bc d0 66 d3 31 01 01 00 80
13:40:15.486 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: create UART services 80 bc 81 66 82 d3 83 31 84 01 85 d1 86 00 87 80 48 97
13:40:15.489 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: write UART services, waiting for .con
13:40:15.522 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 1,489,756 us
13:40:15.551 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: write ACK (0x11) for 6/1/1
13:40:15.552 [DEBUG ] io.calimero.link.tpuart:/dev/ttyAMA0: confirmation of 6/1/1
13:40:15.555 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: finished reading 5 bytes after 67 us
13:40:15.558 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 30,132 us
13:40:15.559 [TRACE ] io.calimero.server.gateway.knx-server: server-side KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2): 6.6.211->6/2/1 L_Data.req, low priority hop count 6 repeat, tpdu 00 80: T_Group, A_Group.write
13:40:15.562 [TRACE ] io.calimero.server.gateway.knx-server: send positive cEMI L_Data.con
13:40:15.562 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: reset receive buffer after 29,935 us, char 0x0, discard partial frame (length 6) bc 66 d3 31 01 d1
13:40:15.564 [DEBUG ] io.calimero.server.gateway.knx-server: dispatch 6.6.211->6/2/1 using KNX IP routing service (eth0 224.0.23.12)
13:40:15.566 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 241 us
13:40:15.567 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): add to multicast loopback frame buffer: 6.6.211->6/2/1 L_Data.ind, low priority hop count 6, tpdu 00 80
13:40:15.568 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: sending cEMI frame seq 3, WaitForAck, attempt 1 (channel 1) 06 10 04 20 00 15 04 01 03 00 2e 00 bc e0 66 d3 32 01 01 00 80
13:40:15.570 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 45 us
13:40:15.572 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 04 20 00 15 04 01 03 00 2e 00 bc e0 66 d3 32 01 01 00 80
13:40:15.573 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): sending cEMI frame seq 0, NonBlocking, attempt 1 (channel 0) 06 10 05 30 00 11 29 00 bc e0 66 d3 32 01 01 00 80
13:40:15.573 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 39 us
13:40:15.576 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: positive L_Data.con
13:40:15.577 [TRACE ] io.calimero.server.gateway.knx-server: forward 6.6.211->6/2/1 L_Data.req, low priority hop count 6 repeat, tpdu 00 80 to all tunneling clients (except 6.6.211)
13:40:15.577 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): discard multicast loopback cEMI frame: 6.6.211->6/2/1 L_Data.ind, low priority hop count 6, tpdu 00 80
13:40:15.580 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: cEMI (length 11): 2e 00 bc d0 66 d3 31 01 01 00 80
13:40:15.582 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): add to multicast loopback frame buffer: 6.6.211->6/2/1 L_Data.ind, low priority hop count 6, tpdu 00 80
13:40:15.583 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: ACK received after 32 ms
13:40:15.586 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 2,449 us
13:40:15.586 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): sending cEMI frame seq 0, NonBlocking, attempt 1 (channel 0) 06 10 05 30 00 11 29 00 bc e0 66 d3 32 01 01 00 80
13:40:15.591 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): discard multicast loopback cEMI frame: 6.6.211->6/2/1 L_Data.ind, low priority hop count 6, tpdu 00 80
13:40:15.591 [TRACE ] io.calimero.server.gateway.knx-server: dispatch to subnet /dev/ttyAMA0: 6.6.211->6/2/1 L_Data.req, low priority hop count 5 repeat, tpdu 00 80
13:40:15.596 [DEBUG ] io.calimero.link.tpuart:/dev/ttyAMA0: send (wait for confirmation) 6.6.211->6/2/1 L_Data.req, low priority hop count 5 repeat, tpdu 00 80
13:40:15.596 [WARNING] io.calimero.serial.tpuart:/dev/ttyAMA0: 4 partial frames discarded, increase max. inter-byte delay to 5,750 us
13:40:15.598 [TRACE ] io.calimero.link.tpuart:/dev/ttyAMA0: send cEMI 11 00 bc d0 66 d3 32 01 01 00 80
13:40:15.599 [DEBUG ] io.calimero.link.tpuart:/dev/ttyAMA0: indication 1.1.4->6/2/1 L_Data.ind, low priority hop count 6, tpdu 00 80
13:40:15.601 [TRACE ] io.calimero.server.gateway.knx-server: subnet /dev/ttyAMA0: 1.1.4->6/2/1 L_Data.ind, low priority hop count 6, tpdu 00 80: T_Group, A_Group.write
13:40:15.602 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: finished reading 5 bytes after 128 us
13:40:15.606 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 8,294 us
13:40:15.609 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 110 us
13:40:15.612 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 57 us
13:40:15.615 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: received TP1 L-Data (length 9): bc 11 04 32 01 e1 00 80 04
13:40:15.619 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: cEMI (length 11): 29 00 bc e0 11 04 32 01 01 00 80
13:40:15.621 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: create UART services 80 bc 81 66 82 d3 83 32 84 01 85 d1 86 00 87 80 48 94
13:40:15.624 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 8,479 us
13:40:15.630 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 04 21 00 0a 04 01 03 00
13:40:15.633 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: write ACK (0x11) for 6/2/1
13:40:15.635 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: received service ack 3 from 192.168.31.101:5559 (channel 1)
13:40:15.636 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: finished reading 5 bytes after 86 us
13:40:15.640 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 29,393 us
13:40:15.644 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: reset receive buffer after 24,500 us, char 0x0, discard partial frame (length 6) 9c 11 04 32 01 e1
13:40:15.647 [TRACE ] io.calimero.server.gateway.ReplayBuffer: record io.calimero.FrameEvent[source=Tpuart link tpuart:/dev/ttyAMA0 TP1 medium, device 6.6.0, hopcount 6] as event '3,228,589,164,001'
13:40:15.647 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 262 us
13:40:15.650 [DEBUG ] io.calimero.server.gateway.knx-server: dispatch 1.1.4->6/2/1 to all server-side connections
13:40:15.650 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 49 us
13:40:15.653 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): add to multicast loopback frame buffer: 1.1.4->6/2/1 L_Data.ind, low priority hop count 5, tpdu 00 80
13:40:15.653 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 39 us
13:40:15.657 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: UART ready for sending after 46,537 us
13:40:15.657 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): sending cEMI frame seq 0, NonBlocking, attempt 1 (channel 0) 06 10 05 30 00 11 29 00 bc d0 11 04 32 01 01 00 80
13:40:15.659 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: write UART services, waiting for .con
13:40:15.662 [TRACE ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): discard multicast loopback cEMI frame: 1.1.4->6/2/1 L_Data.ind, low priority hop count 5, tpdu 00 80
13:40:15.665 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: sending cEMI frame seq 4, WaitForAck, attempt 1 (channel 1) 06 10 04 20 00 15 04 01 04 00 29 00 bc d0 11 04 32 01 01 00 80
13:40:15.668 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 04 20 00 15 04 01 04 00 29 00 bc d0 11 04 32 01 01 00 80
13:40:15.704 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 04 21 00 0a 04 01 04 00
13:40:15.710 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: received service ack 4 from 192.168.31.101:5559 (channel 1)
13:40:15.712 [DEBUG ] io.calimero.server.gateway.ReplayBuffer: KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2) successfully completed event '3,228,589,164,001/3,228,589,164,001'
13:40:15.713 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: write ACK (0x11) for 6/2/1
13:40:15.715 [TRACE ] io.calimero.server.gateway.knx-server: dispatching to KNX subnets: exclude subnet /dev/ttyAMA0
13:40:15.716 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: finished reading 5 bytes after 70 us
13:40:15.720 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 30,323 us
13:40:15.723 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: reset receive buffer after 30,372 us, char 0x0, discard partial frame (length 6) bc 66 d3 32 01 d1
13:40:15.726 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 429 us
13:40:15.729 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 159 us
13:40:15.733 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: finished reading 1 bytes after 5,658 us
13:40:15.736 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 5,967 us
13:40:15.764 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: no ACK received after 82 ms
13:40:15.764 [WARNING] io.calimero.server.gateway.knx-server: timeout sending to 6/2/1: no ACK for L-Data.con
13:40:16.152 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:21292 on [any]
13:40:16.159 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:21292 on [any]
13:40:19.062 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 3,342,637 us
13:40:19.065 [DEBUG ] io.calimero.serial.tpuart:/dev/ttyAMA0: reset receive buffer after 3,345,712 us, char 0x7, discard partial frame (length 2) 94 8b
13:40:19.068 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:19.070 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 3,138 us
13:40:19.931 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:20030 on [any]
13:40:19.937 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:20030 on [any]
13:40:22.209 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:20035 06 10 02 03 00 0e 08 01 00 00 00 00 00 00
13:40:22.217 [DEBUG ] io.calimero.server.knx-server: responses use route-back control endpoint 192.168.31.101:20035
13:40:22.305 [INFO ] io.calimero.server.knx-server: send KNXnet/IP description to 192.168.31.101:20035: "Calimero KNX", KNX address 6.6.0, KNX medium TP1, Installation 0 - Project 0 (ID 0), KNX IP multicast address 224.0.23.12, MAC address b8:27:eb:eb:0c:43, S/N 0000:00000000, Core (v2), Device Management (v2), Tunneling (v2), Routing (v2), 6.6.2, 6.6.3, 6.6.4, KNX manufacturer ID 0x0, data 0x626d323031312020
13:40:22.358 [INFO ] io.calimero.server.knx-server: accepted /dev/ttyAMA0 tcp connection 192.168.31.101:22565
13:40:22.361 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:22565 06 10 02 05 00 1a 08 02 00 00 00 00 00 00 08 02 00 00 00 00 00 00 04 04 02 00
13:40:22.365 [DEBUG ] io.calimero.server.knx-server: responses to client use route-back control endpoint 192.168.31.101:22565
13:40:22.367 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0: setup data endpoint (TCP, channel 2) for connection request from 192.168.31.101:22565
13:40:22.370 [DEBUG ] io.calimero.server.knx-server: responses use route-back data endpoint 192.168.31.101:22565
13:40:22.373 [TRACE ] io.calimero.server.knx-server: address 6.6.2 already assigned
13:40:22.376 [INFO ] io.calimero.server.knx-server: assign additional individual address 6.6.3 to channel 2
13:40:22.378 [DEBUG ] io.calimero.server.knx-server: created socket on 192.168.31.22:52752
13:40:22.382 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 data endpoint KNX IP LinkLayer 192.168.31.101:22565 (TCP, channel 2, 6.6.3) is up and running
13:40:22.385 [DEBUG ] io.calimero.server.gateway.knx-server: established connection KNX IP LinkLayer 192.168.31.101:22565 (TCP, channel 2, 6.6.3)
13:40:22.426 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:22565 06 10 04 24 00 0d 04 02 00 00 08 00 01
13:40:22.438 [DEBUG ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:22565: received tunneling-feat.set enable feature info service 01
13:40:22.442 [DEBUG ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:22565: respond with tunneling-feat.res enable feature info service 01
13:40:22.481 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:22565 06 10 02 07 00 10 02 00 08 02 00 00 00 00 00 00
13:40:22.483 [TRACE ] io.calimero.server.knx-server: received connection-state request (channel 2) from 192.168.31.101:22565
13:40:22.517 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:22565 06 10 02 09 00 10 02 00 08 02 00 00 00 00 00 00
13:40:22.521 [DEBUG ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:22565: close connection for channel 2 - client request
13:40:22.525 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 data endpoint 192.168.31.101:22565 closed
13:40:22.527 [DEBUG ] io.calimero.server.gateway.knx-server: removed connection KNX IP LinkLayer 192.168.31.101:22565 (client request)
13:40:22.545 [INFO ] io.calimero.server.knx-server: close tcp connection to 192.168.31.101:22565
13:40:22.813 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:32482 on [any]
13:40:22.820 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:32482 on [any]
13:40:23.684 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:32485 on [any]
13:40:23.691 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:32485 on [any]
13:40:24.092 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,026,862 us
13:40:24.095 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:24.098 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 289 us
13:40:27.453 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:27109 on [any]
13:40:27.460 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:27109 on [any]
13:40:29.122 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,029,633 us
13:40:29.124 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:29.127 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 2,776 us
13:40:29.301 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 02 05 00 1a 08 01 00 00 00 00 00 00 08 01 00 00 00 00 00 00 04 04 02 00
13:40:29.305 [DEBUG ] io.calimero.server.knx-server: responses to client use route-back control endpoint 192.168.31.101:5559
13:40:29.308 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0: setup data endpoint (UDP NAT, channel 3) for connection request from 192.168.31.101:5559
13:40:29.310 [DEBUG ] io.calimero.server.knx-server: responses use route-back data endpoint 192.168.31.101:5559
13:40:29.313 [TRACE ] io.calimero.server.knx-server: address 6.6.2 already assigned
13:40:29.316 [INFO ] io.calimero.server.knx-server: assign additional individual address 6.6.3 to channel 3
13:40:29.319 [DEBUG ] io.calimero.server.knx-server: created socket on 192.168.31.22:48255
13:40:29.322 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 data endpoint KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 3, 6.6.3) is up and running
13:40:29.323 [DEBUG ] io.calimero.server.gateway.knx-server: established connection KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 3, 6.6.3)
13:40:29.325 [DEBUG ] io.calimero.server.gateway.ReplayBuffer: activate replay buffer for KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 3, 6.6.3)
13:40:29.328 [INFO ] io.calimero.server.gateway.ReplayBuffer: found exact match for Key[hostAddress=192.168.31.101, port=5559, timestamp=1713015629326] in disrupted connections: [KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2)]
13:40:29.332 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 02 07 00 10 03 00 08 01 00 00 00 00 00 00
13:40:29.334 [TRACE ] io.calimero.server.knx-server: received connection-state request (channel 3) from 192.168.31.101:5559
13:40:31.227 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:45383 on [any]
13:40:31.234 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:45383 on [any]
13:40:34.152 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,027,166 us
13:40:34.153 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:34.155 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 2,099 us
13:40:34.981 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:20029 on [any]
13:40:34.988 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:20029 on [any]
13:40:36.254 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 02 05 00 1a 08 01 00 00 00 00 00 00 08 01 00 00 00 00 00 00 04 04 02 00
13:40:36.256 [DEBUG ] io.calimero.server.knx-server: responses to client use route-back control endpoint 192.168.31.101:5559
13:40:36.258 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0: setup data endpoint (UDP NAT, channel 4) for connection request from 192.168.31.101:5559
13:40:36.260 [DEBUG ] io.calimero.server.knx-server: responses use route-back data endpoint 192.168.31.101:5559
13:40:36.262 [TRACE ] io.calimero.server.knx-server: address 6.6.2 already assigned
13:40:36.264 [TRACE ] io.calimero.server.knx-server: address 6.6.3 already assigned
13:40:36.266 [INFO ] io.calimero.server.knx-server: assign additional individual address 6.6.4 to channel 4
13:40:36.268 [DEBUG ] io.calimero.server.knx-server: created socket on 192.168.31.22:46590
13:40:36.272 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 data endpoint KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 4, 6.6.4) is up and running
13:40:36.273 [DEBUG ] io.calimero.server.gateway.knx-server: established connection KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 4, 6.6.4)
13:40:36.277 [DEBUG ] io.calimero.server.gateway.ReplayBuffer: activate replay buffer for KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 4, 6.6.4)
13:40:36.280 [INFO ] io.calimero.server.gateway.ReplayBuffer: found exact match for Key[hostAddress=192.168.31.101, port=5559, timestamp=1713015636278] in disrupted connections: [KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2), KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 3, 6.6.3)]
13:40:36.293 [TRACE ] io.calimero.server.knx-server: /dev/ttyAMA0 received 192.168.31.101:5559 06 10 02 07 00 10 04 00 08 01 00 00 00 00 00 00
13:40:36.296 [TRACE ] io.calimero.server.knx-server: received connection-state request (channel 4) from 192.168.31.101:5559
13:40:38.750 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:20029 on [any]
13:40:38.760 [DEBUG ] io.calimero.server.knx-server: KNXnet/IP discovery: identify as 'Calimero KNX' for container /dev/ttyAMA0 to 192.168.31.101:20029 on [any]
13:40:39.182 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,027,935 us
13:40:39.184 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:39.187 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 739 us
13:40:39.916 [INFO ] io.calimero.server.gateway.knx-server: knx-server: user request for shutdown
13:40:39.954 [DEBUG ] io.calimero.server.knx-server: cleanup knx-server discovery endpoint
13:40:39.956 [INFO ] io.calimero.server.knx-server: knx-server discovery endpoint closed
13:40:39.959 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: sending disconnect request for KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 1, 6.6.2)
13:40:39.961 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 02 09 00 10 01 00 08 01 00 00 00 00 00 00
13:40:44.212 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,029,146 us
13:40:44.214 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:44.217 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 300 us
13:40:49.242 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,029,669 us
13:40:49.244 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:49.247 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 298 us
13:40:49.964 [INFO ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: close connection for channel 1 - quit service container /dev/ttyAMA0
13:40:49.966 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 data endpoint 192.168.31.101:5559 closed
13:40:49.966 [DEBUG ] io.calimero.server.gateway.knx-server: removed connection KNX IP LinkLayer 192.168.31.101:5559 (quit service container /dev/ttyAMA0)
13:40:49.971 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: sending disconnect request for KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 3, 6.6.3)
13:40:49.973 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 02 09 00 10 03 00 08 01 00 00 00 00 00 00
13:40:54.272 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,029,661 us
13:40:54.274 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:54.277 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 280 us
13:40:59.302 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,029,726 us
13:40:59.304 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:40:59.306 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 325 us
13:40:59.975 [INFO ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: close connection for channel 3 - quit service container /dev/ttyAMA0
13:40:59.977 [DEBUG ] io.calimero.server.gateway.knx-server: removed connection KNX IP LinkLayer 192.168.31.101:5559 (quit service container /dev/ttyAMA0)
13:40:59.977 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 data endpoint 192.168.31.101:5559 closed
13:40:59.979 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: sending disconnect request for KNX IP LinkLayer 192.168.31.101:5559 (UDP NAT, channel 4, 6.6.4)
13:40:59.981 [TRACE ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: send 192.168.31.22:3671->192.168.31.101:5559 06 10 02 09 00 10 04 00 08 01 00 00 00 00 00 00
13:41:04.332 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,029,608 us
13:41:04.334 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:41:04.337 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 357 us
13:41:09.362 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: receiver woke from extended idle period of 5,029,552 us
13:41:09.364 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: TP-UART status: Temp. OK
13:41:09.367 [TRACE ] io.calimero.serial.tpuart:/dev/ttyAMA0: loop time = 2,419 us
13:41:09.984 [INFO ] io.calimero.server.knxnetip.KNX IP LinkLayer 192.168.31.101:5559: close connection for channel 4 - quit service container /dev/ttyAMA0
13:41:09.985 [INFO ] io.calimero.server.knx-server: /dev/ttyAMA0 data endpoint 192.168.31.101:5559 closed
13:41:09.985 [DEBUG ] io.calimero.server.gateway.knx-server: removed connection KNX IP LinkLayer 192.168.31.101:5559 (quit service container /dev/ttyAMA0)
13:41:09.988 [DEBUG ] io.calimero.server.knx-server: cleanup knx-server control endpoint /dev/ttyAMA0
13:41:09.988 [DEBUG ] io.calimero.server.knxnetip.KNX IP routing service (eth0 224.0.23.12): close connection - user request
13:41:09.989 [INFO ] io.calimero.server.knx-server: knx-server control endpoint /dev/ttyAMA0 closed
13:41:09.991 [DEBUG ] io.calimero.server.knx-server: cleanup knx-server routing service 224.0.23.12
13:41:09.991 [DEBUG ] io.calimero.server.gateway.knx-server: removed connection KNX IP routing service (eth0 224.0.23.12) (user request)
13:41:09.994 [INFO ] io.calimero.server.knx-server: knx-server routing service 224.0.23.12 closed
13:41:09.999 [DEBUG ] io.calimero.device.knx-server: saving device memory to file:///usr/app/knx-server-ios.xml
13:41:10.071 [DEBUG ] io.calimero.device.knx-server: saving interface object server to file:///usr/app/knx-server-ios.xml
13:41:10.086 [TRACE ] io.calimero.xml.XmlOutputFactory: no StaX implementation found (java.lang.NoClassDefFoundError: javax/xml/stream/XMLStreamException), using internal XMLStreamWriter