Hello,
My SL3P repeats the last mqtt command every 30s when I use the “lockAction” topic. When using “lock” or “unlock” everythings is fine. After a few investigations it seams it’s my MQTT brocker which resend every 30s the command and not the publisher, my domotic server). Perhaps because of the “QoS 2” subscription, the message is always in the “in-flight” state.
Perhaps my brocker is not well configured but I havent changed anything in the configuration during the last months…
It happens on both my SL3P, one with the regular firmware, one with the beta firmware.
Regards
1 Like
Here somes traces from my brocker.
It seems that the SL3P doesn’t send the PUBREC or PUBCOMP for the command sent in the lockAction topic. It does for the command sent int he lock or unlock topic.
Unock action in the “unlock” topic :
2024-05-19T12:36:23.744347+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D0, Topic=nuki/########/unlock, PacketId=1, Payload=true), username: ########
2024-05-19T12:36:23.925987+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREC(Q0, R0, D0, PacketId=1, ReasonCode=0), username: ########
2024-05-19T12:36:23.926177+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREL(Q1, R0, D0, PacketId=1, ReasonCode=0), username: ########
2024-05-19T12:36:23.971433+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/########/state, PacketId=undefined, Payload=2), username: ########
2024-05-19T12:36:23.971633+02:00 [AUTHZ] SL3P_########@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/########/state, username: ########
2024-05-19T12:36:23.971762+02:00 [PUBLISH] SL3P_########@192.168.0.226:52448 msg: publish_to, topic: nuki/########/state, username: ########, payload: 2
2024-05-19T12:36:23.972042+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/########/lockActionEvent, PacketId=4, Payload=1,172,0,0,0), username: ########
2024-05-19T12:36:23.972231+02:00 [AUTHZ] SL3P_########@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/########/lockActionEvent, username: ########
2024-05-19T12:36:23.972311+02:00 [PUBLISH] SL3P_########@192.168.0.226:52448 msg: publish_to, topic: nuki/########/lockActionEvent, username: ########, payload: 1,172,0,0,0
2024-05-19T12:36:23.972417+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBCOMP(Q0, R0, D0, PacketId=1, ReasonCode=0), username: ########
2024-05-19T12:36:23.972525+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=4, ReasonCode=0), username: ########
2024-05-19T12:36:24.015637+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=4, ReasonCode=0), username: ########
2024-05-19T12:36:24.015810+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=4, ReasonCode=0), username: ########
2024-05-19T12:36:24.065862+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/########/timestamp, PacketId=undefined, Payload=2024-05-19T10:36:23Z), username: ########
2024-05-19T12:36:24.066105+02:00 [AUTHZ] SL3P_########@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/########/timestamp, username: ########
2024-05-19T12:36:24.066213+02:00 [PUBLISH] SL3P_########@192.168.0.226:52448 msg: publish_to, topic: nuki/########/timestamp, username: ########, payload: 2024-05-19T10:36:23Z
And in the “lockAction” topic :
2024-05-19T12:37:24.606838+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D0, Topic=nuki/########/lockAction, PacketId=2, Payload=1), username: ########
2024-05-19T12:37:24.755261+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/########/commandResponse, PacketId=6, Payload=0), username: ########
2024-05-19T12:37:24.755524+02:00 [PUBLISH] SL3P_########@192.168.0.226:52448 msg: publish_to, topic: nuki/########/commandResponse, username: ########, payload: 0
2024-05-19T12:37:24.755820+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=6, ReasonCode=0), username: ########
2024-05-19T12:37:24.808900+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=6, ReasonCode=0), username: ########
2024-05-19T12:37:24.809089+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=6, ReasonCode=0), username: ########
2024-05-19T12:37:24.890612+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/########/lockActionEvent, PacketId=7, Payload=1,172,0,0,0), username: ########
2024-05-19T12:37:24.890881+02:00 [AUTHZ] SL3P_########@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/########/lockActionEvent, username: ########
2024-05-19T12:37:24.890974+02:00 [PUBLISH] SL3P_########@192.168.0.226:52448 msg: publish_to, topic: nuki/########/lockActionEvent, username: ########, payload: 1,172,0,0,0
2024-05-19T12:37:24.891232+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=7, ReasonCode=0), username: ########
2024-05-19T12:37:24.955124+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=7, ReasonCode=0), username: ########
2024-05-19T12:37:24.955308+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=7, ReasonCode=0), username: ########
2024-05-19T12:37:25.012424+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/########/timestamp, PacketId=undefined, Payload=2024-05-19T10:37:24Z), username: ########
2024-05-19T12:37:25.012678+02:00 [AUTHZ] SL3P_########@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/########/timestamp, username: ########
2024-05-19T12:37:25.012783+02:00 [PUBLISH] SL3P_########@192.168.0.226:52448 msg: publish_to, topic: nuki/########/timestamp, username: ########, payload: 2024-05-19T10:37:24Z
2024-05-19T12:37:54.607218+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D1, Topic=nuki/########/lockAction, PacketId=2, Payload=1), username: ########
2024-05-19T12:37:55.092371+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/########/commandResponse, PacketId=8, Payload=0), username: ########
2024-05-19T12:37:55.092626+02:00 [AUTHZ] SL3P_########@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/########/commandResponse, username: ########
2024-05-19T12:37:55.092735+02:00 [PUBLISH] SL3P_########@192.168.0.226:52448 msg: publish_to, topic: nuki/########/commandResponse, username: ########, payload: 0
2024-05-19T12:37:55.092844+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=8, ReasonCode=0), username: ########
2024-05-19T12:37:55.155582+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=8, ReasonCode=0), username: ########
2024-05-19T12:37:55.155816+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=8, ReasonCode=0), username: ########
2024-05-19T12:37:55.228719+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/########/lockActionEvent, PacketId=9, Payload=1,172,0,0,0), username: ########
2024-05-19T12:37:55.228946+02:00 [PUBLISH] SL3P_########@192.168.0.226:52448 msg: publish_to, topic: nuki/########/lockActionEvent, username: ########, payload: 1,172,0,0,0
2024-05-19T12:37:55.229079+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=9, ReasonCode=0), username: ########
2024-05-19T12:37:55.275741+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=9, ReasonCode=0), username: ########
2024-05-19T12:37:55.275888+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=9, ReasonCode=0), username: ########
2024-05-19T12:37:55.345680+02:00 [MQTT] SL3P_########@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/########/timestamp, PacketId=undefined, Payload=2024-05-19T10:37:54Z), username: ########
2024-05-19T12:37:55.345927+02:00 [PUBLISH] SL3P_########@192.168.0.226:52448 msg: publish_to, topic: nuki/########/timestamp, username: ########, payload: 2024-05-19T10:37:54Z
I have the same problem. I reached out to support and they redirected me to forums for MQTT related problems.
I’m using door lock(SL3P) with home assistant over MQTT and after updating to version 3.9.5 I have problems.
After sending command to lockAction topic with QOS 2 the command is executed by the lock but the messages is not “consumed”. The lock is then repeating the same commanded over and over approximately every 30 seconds. It only stops after I disconnect the lock from the MQTT broker. All the actions are logged in the activity log of the lock. This only happens if messages are sent with QOS 1 or 2. When I send the command with QOS 0 it works correctly and doesn’t end up in a loop. The broker shows the messages as inflight.
My broker is EMQX version 5.6.1 open source, installed as HA addon.
I was using this setup over 6 months and everything was working fine and without problems before the update. The problem is not limited to home assistant. I can get the lock into the loop with any other MQTT client such as MQTTX.
1 Like
In your logs of the lockAction topic you’re immediately receiving commandReponse: 0, so it seems you unlocked an already unlocked door while within the log of the unlock topic the door seems to really unlock and the log does not contain a commandResponse at all (probably log just not complete).
Or maybe the Smart Lock was locked but the log starts not with the first executed lock action.
Maybe the immediate commandResponse is confusing EMQX somehow.
Could you attach another log of using the lockAction topic to unlock the door when the Smart Lock is locked for comparison?
Hi Marc,
You’ll find attached another log with a real modification of the lock state. Each subsequent “lockAction” resent by the brocker and received by the lock is written in the lock logs of the app.
The lock doesn’t comply with the QoS 2 specification, which requires a PUBREC and a PUBCOMP (but it does not send them regardless of its state) as sent with the others topics (“lock” and “unlok”).
2024-05-21T09:33:36.372758+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockAction, PacketId=1, Payload=1), username: xxxx
2024-05-21T09:33:36.790445+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/state, PacketId=undefined, Payload=2), username: xxxx
2024-05-21T09:33:36.790684+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.179:52450 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/state, username: xxxx
2024-05-21T09:33:36.790806+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/state, username: xxxx, payload: 2
2024-05-21T09:33:37.315960+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockActionEvent, PacketId=6, Payload=1,172,0,0,0), username: xxxx
2024-05-21T09:33:37.316184+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.179:52450 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx
2024-05-21T09:33:37.316325+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx, payload: 1,172,0,0,0
2024-05-21T09:33:37.316434+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=6, ReasonCode=0), username: xxxx
2024-05-21T09:33:37.977151+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=6, ReasonCode=0), username: xxxx
2024-05-21T09:33:37.977355+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=6, ReasonCode=0), username: xxxx
2024-05-21T09:33:38.445754+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-21T07:33:36Z), username: xxxx
2024-05-21T09:33:38.445972+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.179:52450 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/timestamp, username: xxxx
2024-05-21T09:33:38.446073+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-21T07:33:36Z
2024-05-21T09:33:39.720956+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/commandResponse, PacketId=7, Payload=0), username: xxxx
2024-05-21T09:33:39.721192+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.179:52450 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/commandResponse, username: xxxx
2024-05-21T09:33:39.721312+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/commandResponse, username: xxxx, payload: 0
2024-05-21T09:33:39.721435+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=7, ReasonCode=0), username: xxxx
2024-05-21T09:33:39.765923+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=7, ReasonCode=0), username: xxxx
2024-05-21T09:33:39.766078+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=7, ReasonCode=0), username: xxxx
2024-05-21T09:33:39.849816+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/state, PacketId=undefined, Payload=3), username: xxxx
2024-05-21T09:33:39.850026+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/state, username: xxxx, payload: 3
2024-05-21T09:33:40.663573+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-21T07:33:38Z), username: xxxx
2024-05-21T09:33:40.663778+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-21T07:33:38Z
2024-05-21T09:34:06.373150+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D1, Topic=nuki/XXXXXXXX/lockAction, PacketId=1, Payload=1), username: xxxx
2024-05-21T09:34:08.691364+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/commandResponse, PacketId=8, Payload=0), username: xxxx
2024-05-21T09:34:08.691552+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/commandResponse, username: xxxx, payload: 0
2024-05-21T09:34:08.691645+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=8, ReasonCode=0), username: xxxx
2024-05-21T09:34:08.790349+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=8, ReasonCode=0), username: xxxx
2024-05-21T09:34:08.790508+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=8, ReasonCode=0), username: xxxx
2024-05-21T09:34:08.866310+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockActionEvent, PacketId=9, Payload=1,172,0,0,0), username: xxxx
2024-05-21T09:34:08.866519+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx, payload: 1,172,0,0,0
2024-05-21T09:34:08.866646+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=9, ReasonCode=0), username: xxxx
2024-05-21T09:34:08.921062+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=9, ReasonCode=0), username: xxxx
2024-05-21T09:34:08.921206+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=9, ReasonCode=0), username: xxxx
2024-05-21T09:34:10.115244+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-21T07:34:07Z), username: xxxx
2024-05-21T09:34:10.115512+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-21T07:34:07Z
2024-05-21T09:34:33.924840+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/serverConnected, PacketId=undefined, Payload=true), username: xxxx
2024-05-21T09:34:33.924977+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.179:52450 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/serverConnected, username: xxxx
2024-05-21T09:34:33.925025+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/serverConnected, username: xxxx, payload: true
2024-05-21T09:34:35.205143+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-21T07:34:34Z), username: xxxx
2024-05-21T09:34:35.205385+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-21T07:34:34Z
2024-05-21T09:34:36.374168+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D1, Topic=nuki/XXXXXXXX/lockAction, PacketId=1, Payload=1), username: xxxx
2024-05-21T09:34:37.096565+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/commandResponse, PacketId=10, Payload=0), username: xxxx
2024-05-21T09:34:37.096817+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/commandResponse, username: xxxx, payload: 0
2024-05-21T09:34:37.096957+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=10, ReasonCode=0), username: xxxx
2024-05-21T09:34:39.640037+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=10, ReasonCode=0), username: xxxx
2024-05-21T09:34:39.640198+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=10, ReasonCode=0), username: xxxx
2024-05-21T09:34:39.685969+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockActionEvent, PacketId=11, Payload=1,172,0,0,0), username: xxxx
2024-05-21T09:34:39.686207+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.179:52450 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx
2024-05-21T09:34:39.686273+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx, payload: 1,172,0,0,0
2024-05-21T09:34:39.686368+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=11, ReasonCode=0), username: xxxx
2024-05-21T09:34:39.738256+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=11, ReasonCode=0), username: xxxx
2024-05-21T09:34:39.738415+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=11, ReasonCode=0), username: xxxx
2024-05-21T09:34:39.782477+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-21T07:34:38Z), username: xxxx
2024-05-21T09:34:39.782709+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.179:52450 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/timestamp, username: xxxx
2024-05-21T09:34:39.782852+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-21T07:34:38Z
2024-05-21T09:35:06.375179+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D1, Topic=nuki/XXXXXXXX/lockAction, PacketId=1, Payload=1), username: xxxx
2024-05-21T09:35:07.555572+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/commandResponse, PacketId=12, Payload=0), username: xxxx
2024-05-21T09:35:07.555790+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.179:52450 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/commandResponse, username: xxxx
2024-05-21T09:35:07.555866+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/commandResponse, username: xxxx, payload: 0
2024-05-21T09:35:07.555978+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=12, ReasonCode=0), username: xxxx
2024-05-21T09:35:08.069960+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=12, ReasonCode=0), username: xxxx
2024-05-21T09:35:08.070075+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=12, ReasonCode=0), username: xxxx
2024-05-21T09:35:09.407129+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockActionEvent, PacketId=13, Payload=1,172,0,0,0), username: xxxx
2024-05-21T09:35:09.407423+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx, payload: 1,172,0,0,0
2024-05-21T09:35:09.407562+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=13, ReasonCode=0), username: xxxx
2024-05-21T09:35:09.445509+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=13, ReasonCode=0), username: xxxx
2024-05-21T09:35:09.445668+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=13, ReasonCode=0), username: xxxx
2024-05-21T09:35:09.503669+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.179:52450 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-21T07:35:08Z), username: xxxx
2024-05-21T09:35:09.503945+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.179:52450 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-21T07:35:08Z
Here is the unabridged first log :
2024-05-19T12:34:49.533903+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52447 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/connected, username: xxxx
2024-05-19T12:34:49.534048+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52447 msg: publish_to, topic: nuki/XXXXXXXX/connected, username: xxxx, payload: false
2024-05-19T12:34:49.534564+02:00 [SOCKET] SL3P_XXXXXXXX@192.168.0.226:52447 msg: emqx_connection_terminated, reason: {shutdown,kicked}, username: xxxx
2024-05-19T12:34:50.233590+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: CONNECT(Q0, R0, D0, ClientId=SL3P_XXXXXXXX, ProtoName=MQTT, ProtoVsn=4, CleanStart=true, KeepAlive=300, Username=mqtt, Password=******, Will(Q0, R1, Topic=nuki/XXXXXXXX/connected Payload=false)), username: xxxx
2024-05-19T12:34:50.233857+02:00 [AUTHN] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authenticator_result, authenticator: password_based:built_in_database, result: {ok,#{is_superuser => false}}, username: xxxx
2024-05-19T12:34:50.233943+02:00 [AUTHN] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authentication_result, reason: chain_result, result: {stop,{ok,#{is_superuser => false}}}, username: xxxx
2024-05-19T12:34:50.234466+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: CONNACK(Q0, R0, D0, AckFlags=0, ReasonCode=0), username: xxxx
2024-05-19T12:34:50.305234+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/connected, PacketId=undefined, Payload=true), username: xxxx
2024-05-19T12:34:50.305451+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/connected, username: xxxx
2024-05-19T12:34:50.305541+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/connected, username: xxxx, payload: true
2024-05-19T12:34:50.676646+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: SUBSCRIBE(Q1, R0, D0, PacketId=1 TopicFilters=[nuki/XXXXXXXX/lockAction(#{nl => 0,qos => 2,rap => 0,rh => 0})]), username: xxxx
2024-05-19T12:34:50.676830+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: SUBSCRIBE(Q2), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/lockAction, username: xxxx
2024-05-19T12:34:50.676882+02:00 [SUBSCRIBE] SL3P_XXXXXXXX@192.168.0.226:52448 msg: subscribe, sub_id: SL3P_XXXXXXXX, sub_opts: [nl: 0, qos: 2, rap: 0, rh: 0, sub_props: []], topic: nuki/XXXXXXXX/lockAction, username: xxxx
2024-05-19T12:34:50.677087+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: SUBACK(Q0, R0, D0, PacketId=1, ReasonCodes=[2]), username: xxxx
2024-05-19T12:34:50.773025+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: SUBSCRIBE(Q1, R0, D0, PacketId=2 TopicFilters=[nuki/XXXXXXXX/lock(#{nl => 0,qos => 2,rap => 0,rh => 0})]), username: xxxx
2024-05-19T12:34:50.773256+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: SUBSCRIBE(Q2), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/lock, username: xxxx
2024-05-19T12:34:50.773356+02:00 [SUBSCRIBE] SL3P_XXXXXXXX@192.168.0.226:52448 msg: subscribe, sub_id: SL3P_XXXXXXXX, sub_opts: [nl: 0, qos: 2, rap: 0, rh: 0, sub_props: []], topic: nuki/XXXXXXXX/lock, username: xxxx
2024-05-19T12:34:50.773694+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: SUBACK(Q0, R0, D0, PacketId=2, ReasonCodes=[2]), username: xxxx
2024-05-19T12:34:50.826443+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: SUBSCRIBE(Q1, R0, D0, PacketId=3 TopicFilters=[nuki/XXXXXXXX/unlock(#{nl => 0,qos => 2,rap => 0,rh => 0})]), username: xxxx
2024-05-19T12:34:50.826628+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: SUBSCRIBE(Q2), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/unlock, username: xxxx
2024-05-19T12:34:50.826716+02:00 [SUBSCRIBE] SL3P_XXXXXXXX@192.168.0.226:52448 msg: subscribe, sub_id: SL3P_XXXXXXXX, sub_opts: [nl: 0, qos: 2, rap: 0, rh: 0, sub_props: []], topic: nuki/XXXXXXXX/unlock, username: xxxx
2024-05-19T12:34:50.827098+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: SUBACK(Q0, R0, D0, PacketId=3, ReasonCodes=[2]), username: xxxx
2024-05-19T12:36:23.744347+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/unlock, PacketId=1, Payload=true), username: xxxx
2024-05-19T12:36:23.925987+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREC(Q0, R0, D0, PacketId=1, ReasonCode=0), username: xxxx
2024-05-19T12:36:23.926177+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREL(Q1, R0, D0, PacketId=1, ReasonCode=0), username: xxxx
2024-05-19T12:36:23.971433+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/state, PacketId=undefined, Payload=2), username: xxxx
2024-05-19T12:36:23.971633+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/state, username: xxxx
2024-05-19T12:36:23.971762+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/state, username: xxxx, payload: 2
2024-05-19T12:36:23.972042+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockActionEvent, PacketId=4, Payload=1,172,0,0,0), username: xxxx
2024-05-19T12:36:23.972231+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx
2024-05-19T12:36:23.972311+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx, payload: 1,172,0,0,0
2024-05-19T12:36:23.972417+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBCOMP(Q0, R0, D0, PacketId=1, ReasonCode=0), username: xxxx
2024-05-19T12:36:23.972525+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=4, ReasonCode=0), username: xxxx
2024-05-19T12:36:24.015637+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=4, ReasonCode=0), username: xxxx
2024-05-19T12:36:24.015810+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=4, ReasonCode=0), username: xxxx
2024-05-19T12:36:24.065862+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-19T10:36:23Z), username: xxxx
2024-05-19T12:36:24.066105+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/timestamp, username: xxxx
2024-05-19T12:36:24.066213+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-19T10:36:23Z
2024-05-19T12:36:27.605322+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/commandResponse, PacketId=5, Payload=0), username: xxxx
2024-05-19T12:36:27.605530+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/commandResponse, username: xxxx
2024-05-19T12:36:27.605619+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/commandResponse, username: xxxx, payload: 0
2024-05-19T12:36:27.605899+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=5, ReasonCode=0), username: xxxx
2024-05-19T12:36:27.651588+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=5, ReasonCode=0), username: xxxx
2024-05-19T12:36:27.651762+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=5, ReasonCode=0), username: xxxx
2024-05-19T12:36:27.728040+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-19T10:36:27Z), username: xxxx
2024-05-19T12:36:27.728276+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-19T10:36:27Z
2024-05-19T12:36:28.448003+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/state, PacketId=undefined, Payload=3), username: xxxx
2024-05-19T12:36:28.448230+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/state, username: xxxx, payload: 3
2024-05-19T12:36:28.496987+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-19T10:36:28Z), username: xxxx
2024-05-19T12:36:28.497269+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-19T10:36:28Z
2024-05-19T12:37:24.606838+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockAction, PacketId=2, Payload=1), username: xxxx
2024-05-19T12:37:24.755261+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/commandResponse, PacketId=6, Payload=0), username: xxxx
2024-05-19T12:37:24.755524+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/commandResponse, username: xxxx, payload: 0
2024-05-19T12:37:24.755820+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=6, ReasonCode=0), username: xxxx
2024-05-19T12:37:24.808900+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=6, ReasonCode=0), username: xxxx
2024-05-19T12:37:24.809089+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=6, ReasonCode=0), username: xxxx
2024-05-19T12:37:24.890612+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockActionEvent, PacketId=7, Payload=1,172,0,0,0), username: xxxx
2024-05-19T12:37:24.890881+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx
2024-05-19T12:37:24.890974+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx, payload: 1,172,0,0,0
2024-05-19T12:37:24.891232+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=7, ReasonCode=0), username: xxxx
2024-05-19T12:37:24.955124+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=7, ReasonCode=0), username: xxxx
2024-05-19T12:37:24.955308+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=7, ReasonCode=0), username: xxxx
2024-05-19T12:37:25.012424+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-19T10:37:24Z), username: xxxx
2024-05-19T12:37:25.012678+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/timestamp, username: xxxx
2024-05-19T12:37:25.012783+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-19T10:37:24Z
2024-05-19T12:37:54.607218+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D1, Topic=nuki/XXXXXXXX/lockAction, PacketId=2, Payload=1), username: xxxx
2024-05-19T12:37:55.092371+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/commandResponse, PacketId=8, Payload=0), username: xxxx
2024-05-19T12:37:55.092626+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/commandResponse, username: xxxx
2024-05-19T12:37:55.092735+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/commandResponse, username: xxxx, payload: 0
2024-05-19T12:37:55.092844+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=8, ReasonCode=0), username: xxxx
2024-05-19T12:37:55.155582+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=8, ReasonCode=0), username: xxxx
2024-05-19T12:37:55.155816+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=8, ReasonCode=0), username: xxxx
2024-05-19T12:37:55.228719+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockActionEvent, PacketId=9, Payload=1,172,0,0,0), username: xxxx
2024-05-19T12:37:55.228946+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx, payload: 1,172,0,0,0
2024-05-19T12:37:55.229079+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=9, ReasonCode=0), username: xxxx
2024-05-19T12:37:55.275741+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=9, ReasonCode=0), username: xxxx
2024-05-19T12:37:55.275888+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=9, ReasonCode=0), username: xxxx
2024-05-19T12:37:55.345680+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-19T10:37:54Z), username: xxxx
2024-05-19T12:37:55.345927+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-19T10:37:54Z
2024-05-19T12:38:24.608271+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D1, Topic=nuki/XXXXXXXX/lockAction, PacketId=2, Payload=1), username: xxxx
2024-05-19T12:38:24.991337+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/commandResponse, PacketId=10, Payload=0), username: xxxx
2024-05-19T12:38:24.991567+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/commandResponse, username: xxxx, payload: 0
2024-05-19T12:38:24.991694+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=10, ReasonCode=0), username: xxxx
2024-05-19T12:38:25.054295+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=10, ReasonCode=0), username: xxxx
2024-05-19T12:38:25.054476+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=10, ReasonCode=0), username: xxxx
2024-05-19T12:38:25.096994+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-19T10:38:23Z), username: xxxx
2024-05-19T12:38:25.097257+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q0,R1), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/timestamp, username: xxxx
2024-05-19T12:38:25.097355+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-19T10:38:23Z
2024-05-19T12:38:25.454006+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockActionEvent, PacketId=11, Payload=1,172,0,0,0), username: xxxx
2024-05-19T12:38:25.454214+02:00 [AUTHZ] SL3P_XXXXXXXX@192.168.0.226:52448 msg: authorization_module_nomatch, action: PUBLISH(Q2,R0), module: emqx_authz_client_info, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx
2024-05-19T12:38:25.454315+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx, payload: 1,172,0,0,0
2024-05-19T12:38:25.454410+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=11, ReasonCode=0), username: xxxx
2024-05-19T12:38:25.506239+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=11, ReasonCode=0), username: xxxx
2024-05-19T12:38:25.506427+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=11, ReasonCode=0), username: xxxx
2024-05-19T12:38:25.555566+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-19T10:38:24Z), username: xxxx
2024-05-19T12:38:25.555795+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-19T10:38:24Z
2024-05-19T12:38:54.609250+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBLISH(Q2, R0, D1, Topic=nuki/XXXXXXXX/lockAction, PacketId=2, Payload=1), username: xxxx
2024-05-19T12:38:54.945763+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/commandResponse, PacketId=12, Payload=0), username: xxxx
2024-05-19T12:38:54.945996+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/commandResponse, username: xxxx, payload: 0
2024-05-19T12:38:54.946120+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=12, ReasonCode=0), username: xxxx
2024-05-19T12:38:55.169043+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=12, ReasonCode=0), username: xxxx
2024-05-19T12:38:55.169248+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=12, ReasonCode=0), username: xxxx
2024-05-19T12:38:55.640568+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q2, R0, D0, Topic=nuki/XXXXXXXX/lockActionEvent, PacketId=13, Payload=1,172,0,0,0), username: xxxx
2024-05-19T12:38:55.640794+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/lockActionEvent, username: xxxx, payload: 1,172,0,0,0
2024-05-19T12:38:55.640921+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBREC(Q0, R0, D0, PacketId=13, ReasonCode=0), username: xxxx
2024-05-19T12:38:55.872906+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBREL(Q1, R0, D0, PacketId=13, ReasonCode=0), username: xxxx
2024-05-19T12:38:55.873057+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_sent, packet: PUBCOMP(Q0, R0, D0, PacketId=13, ReasonCode=0), username: xxxx
2024-05-19T12:38:56.035594+02:00 [MQTT] SL3P_XXXXXXXX@192.168.0.226:52448 msg: mqtt_packet_received, packet: PUBLISH(Q0, R1, D0, Topic=nuki/XXXXXXXX/timestamp, PacketId=undefined, Payload=2024-05-19T10:38:55Z), username: xxxx
2024-05-19T12:38:56.035831+02:00 [PUBLISH] SL3P_XXXXXXXX@192.168.0.226:52448 msg: publish_to, topic: nuki/XXXXXXXX/timestamp, username: xxxx, payload: 2024-05-19T10:38:55Z
2024-05-19T12:39:24.467484+02:00 [API] SL3P_XXXXXXXX@ msg: trace_stopping,
Thanks for the logs.
Mosquitto seems to ignore this.
But I’ve also been able to trace this now with wireshark.
We’ll be looking into this and I’ll keep you updated here.
Thanks for reporting.
2 Likes
With todays 3.10.1 beta update this should be fixed.
Please test and give feedback.
It seems Ok, thank you !
1 Like