Sonoff Zigbee Bridge Pro with Tasmota freezing when multiple commands received via Zigbee network

[msehome]

ZbBP with Tasmota stops working or becomes very sluggish after like 50 or more commands sent consequently in a matter of say 15 to 20 seconds.
I have an Orvibo Mix Switch (scenario button) with 6 gangs and when I click like 4 of them one after the other the ZBB becomes unresponsive.
The solution to this problem is a power cycle. Sometimes I also need to restart the Zigbee2Mqtt as well but power cycle is a mandatory step.
Checking the MQTT messages, every click of a button sends off the same message about 6 times in a matter of 10 seconds.
So I created a filter in Node-red that allows a message through every 10 seconds to avoid duplicates.
Zigbee2mqtt "debounce" on the other hand is not a good options as it delays the command for as long as new "same messages" come in.
Am I doing anything wrong or is it the nature of ZbBP and Tasmota to stop responding so quickly and is there a workaround?

[Jason2866]

Moving to discussions since none of the needed issues Infos provided

[s-hadinger]

Can you provide logs?

[msehome]

Yes of course. Just please let me know which logs you would need and where to get them?

[msehome]

15:19:58.679 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T15:19:58","Uptime":"0T07:35:32","UptimeSec":27332,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-10,"LinkCount":2,"Downtime":"0T00:00:43"}}
15:24:58.672 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T15:24:58","Uptime":"0T07:40:32","UptimeSec":27632,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-9,"LinkCount":2,"Downtime":"0T00:00:43"}}
15:29:58.677 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T15:29:58","Uptime":"0T07:45:32","UptimeSec":27932,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-9,"LinkCount":2,"Downtime":"0T00:00:43"}}
15:34:58.638 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T15:34:58","Uptime":"0T07:50:32","UptimeSec":28232,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-10,"LinkCount":2,"Downtime":"0T00:00:43"}}
15:39:58.633 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T15:39:58","Uptime":"0T07:55:32","UptimeSec":28532,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-9,"LinkCount":2,"Downtime":"0T00:00:43"}}
15:44:58.644 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T15:44:58","Uptime":"0T08:00:32","UptimeSec":28832,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-9,"LinkCount":2,"Downtime":"0T00:00:43"}}
15:49:58.680 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T15:49:58","Uptime":"0T08:05:32","UptimeSec":29132,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-10,"LinkCount":2,"Downtime":"0T00:00:43"}}
15:54:58.649 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T15:54:58","Uptime":"0T08:10:32","UptimeSec":29432,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-10,"LinkCount":2,"Downtime":"0T00:00:43"}}
15:59:58.658 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T15:59:58","Uptime":"0T08:15:32","UptimeSec":29732,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-10,"LinkCount":2,"Downtime":"0T00:00:43"}}
16:04:58.678 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T16:04:58","Uptime":"0T08:20:32","UptimeSec":30032,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-10,"LinkCount":2,"Downtime":"0T00:00:43"}}
16:09:58.661 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T16:09:58","Uptime":"0T08:25:32","UptimeSec":30332,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-10,"LinkCount":2,"Downtime":"0T00:00:43"}}
16:14:58.662 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T16:14:58","Uptime":"0T08:30:32","UptimeSec":30632,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-10,"LinkCount":2,"Downtime":"0T00:00:43"}}
16:19:58.663 MQT: tele/bridge1_C00478/STATE = {"Time":"2024-10-18T16:19:58","Uptime":"0T08:35:32","UptimeSec":30932,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":19,"MqttCount":2,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-10,"LinkCount":2,"Downtime":"0T00:00:43"}}
16:21:01.079 MQT: Attempting connection...
16:21:01.149 MQT: Connected
16:21:01.154 MQT: tele/bridge1_C00478/LWT = Online (retained)
16:21:01.156 MQT: cmnd/bridge1_C00478/POWER = 
16:21:02.722 MQT: stat/bridge1_C00478/STATUS11 = {"StatusSTS":{"Time":"2024-10-18T16:21:02","Uptime":"0T08:36:36","UptimeSec":30996,"Heap":160,"SleepMode":"Dynamic","Sleep":50,"LoadAvg":434,"MqttCount":3,"Berry":{"HeapUsed":3,"Objects":47},"Wifi":{"AP":1,"SSId":"MSE-A","BSSId":"C8:3A:35:09:04:21","Channel":8,"Mode":"HT20","RSSI":100,"Signal":-10,"LinkCount":2,"Downtime":"0T00:00:43"}}}
16:21:02.768 MQT: stat/bridge1_C00478/STATUS1 = {"StatusPRM":{"Baudrate":115200,"SerialConfig":"8N1","GroupTopic":"tasmotas","OtaUrl":"https://ota.tasmota.com/tasmota32/tasmota32-zbbrdgpro.bin","RestartReason":"Vbat power on reset","Uptime":"0T08:36:36","StartupUTC":"2024-10-18T06:44:26","Sleep":50,"CfgHolder":4617,"BootCount":50,"BCResetTime":"2024-10-08T21:56:00","SaveCount":68}}
16:24:29.878 CMD: weblog2
16:24:29.882 MQT: stat/bridge1_C00478/RESULT = {"WebLog":2}
16:24:46.030 CMD: weblog
16:24:46.035 MQT: stat/bridge1_C00478/RESULT = {"WebLog":2}
16:24:57.435 CMD: template
16:24:57.443 MQT: stat/bridge1_C00478/RESULT = {"NAME":"TCP ZBBridge Pro","GPIO":[0,0,576,0,480,0,0,0,0,1,1,5792,0,0,0,5472,0,320,5793,5504,0,640,608,32,0,0,0,0,0,1,0,0,0,0,0,0],"FLAG":0,"BASE":1}

[msehome]

I hope I have got everything you need.
Just noticed that the log timestamp is also not correct the time is around 2 hrs behind the actual time.

[s-hadinger]

What I meant is logs for the moment when the problem occurs. Your logs show no activity.

[msehome]

Oh ok so I will need to try to replicate the issue and at the same time get the log.
Is there a way to dump the log for a while?

[s-hadinger]

Just leave the Tasmota console open in a browser and trigger the commands that created the problem in the first place

[msehome]

While trying to replicate the issue I noticed a VBat error in the console, so replaced the power supply and now I am testing again. Let's see if it fixes the issue.