Tube's ZB Coordinators and Routers (was Zigbee router on steroids?)

tube0013 · July 10, 2024, 12:56pm

I’m not aware of any issues. generally when you don’t see pairing attempts the network isn’t see them, as the device is responsible for broadcasting those. FWIW I ended up removing all the Ikea repeaters on my network a few months ago.

craggus2000 · July 10, 2024, 1:34pm

I got them on a whim as want to have a couple of zigbee devices in my greenhouse, but it would seem the toughened glass completely drops the signal. So my thought was to put a repeater in my shed to see if it is strong enough to get thru the glass, as the signal from my house is about 8m further away. Do you know how the signal strength of your repeaters compares to the Ikea repeaters?

tube0013 · July 10, 2024, 1:48pm

it should be better, I’ve also been impressed with the third reality plugs as repeaters.

I put some soil sensors out in my garden. it’s about 8-10 meters from back of house. the sensors are joined to mesh through an ~~ikea~~ hue bulb in my attic though, so you may want to try staging a routing device high up to see if it gets better range. Inside the back wall of the house are a bunch of plugs and bulbs, and it still chose the attic bulb as the best router.

craggus2000 · July 10, 2024, 1:54pm

I’m sure its the toughened glass that’s killing it. Will try in the roof of my shed, as its less than 2 metres away from the greenhouse - can’t get much closer! Not sure third reality is a thing in the UK. If I can prove some sort of signal in to the greenhouse I’ll order one of your repeaters, but need to confirm a reliable signal first.

Shggy · August 10, 2024, 6:43pm

I have a P7 POE that stops responding at random intervals (most recent time was over a week, can be less than a day). I have re-flashed the P7 firmware and the esphome firmware to no change. Anything else I can check?

tube0013 · August 10, 2024, 7:06pm

try using a static IP.

I just set up a Github Repo to build fw for specific static IPs. https://github.com/tube0013/TubesZB-ESPHome-Builder/issues

create a new issue, fill out the form with the requested information, and copy the model name from the list of available ones in the description of the field. For example:

after submitting which in about 5 minutes you should see an update to the issue with a download link for Firmware:

The downloaded zip file will contain 2 binaries:

Use the firmware.factory.bin to flash via web.esphome.io
or use the firmware.ota.bin, if you have a coordinator with the OTA fw update available in the web front end (note any firmware base on the esp32-idf framework will not - this includes the p7 and mgm24)

SpecialSchoolTech · August 11, 2024, 4:02am

I’m having some issues getting a tubeszb-efr32-mgm210-poe-2023 working with HA and was wondering if anyone could point me in the right direction. I can’t get HA to talk to the unit.

Setup details:
HA Server IP: 10.30.70.10
HA Core: 2024.7.4
HA Supervisor: 2024.08.0
HA OS: 12.4
tubeszb-efr32-mgm210-poe-2023 10.30.70.20

Here is what I have tried so far:

Updated ESPHome via web UI successfully to tubeszb-efr32-mgm210-poe-2023_Legacy.bin

I have not attempted to update the bootloader as I am unsure which gbl to use given the ones I think could be are all labelled 2022.

ZHA:

Automatically detected by HA as tubeszb-efr32-mgm210-poe-2023
Clicked Configure
Serial device path socket://10.30.70.20:6638 Port speed 115200 Flow control software
Error: Failed to connect
Manually attempted the same via + Add Integration button resulting in the same error

Z2M:

Set serial config to port: tcp://10.30.70.20:6638

Log:

[2024-08-11 13:07:29] info: 	z2m: Logging to console, file (filename: log.log)
[2024-08-11 13:07:29] info: 	z2m: Starting Zigbee2MQTT version 1.39.1 (commit #unknown)
[2024-08-11 13:07:29] info: 	z2m: Starting zigbee-herdsman (0.55.3)
[2024-08-11 13:07:29] info: 	zh:zstack:znp: Opening TCP socket with 10.30.70.20:6638
[2024-08-11 13:07:29] info: 	zh:zstack:znp: Socket connected
[2024-08-11 13:07:29] info: 	zh:zstack:znp: Socket ready
[2024-08-11 13:07:29] info: 	zh:zstack:znp: Writing CC2530/CC2531 skip bootloader payload
[2024-08-11 13:07:30] info: 	zh:zstack:znp: Skip bootloader for CC2652/CC1352
[2024-08-11 13:07:48] error: 	z2m: Error while starting zigbee-herdsman
[2024-08-11 13:07:48] error: 	z2m: Failed to start zigbee
[2024-08-11 13:07:48] error: 	z2m: Check https://www.zigbee2mqtt.io/guide/installation/20_zigbee2mqtt-fails-to-start.html for possible solutions
[2024-08-11 13:07:48] error: 	z2m: Exiting...
[2024-08-11 13:07:48] error: 	z2m: Error: Failed to connect to the adapter (Error: SRSP - SYS - ping after 6000ms)
    at ZStackAdapter.start (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/adapter/zStackAdapter.ts:119:27)
    at Controller.start (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:127:29)
    at Zigbee.start (/app/lib/zigbee.ts:63:27)
    at Controller.start (/app/lib/controller.ts:139:27)
    at start (/app/index.js:154:5)

Added adapter: ezsp to serial config
Error: [2024-08-11 12:32:39] warning: zh:ezsp: Deprecated driver 'ezsp' currently in use, 'ember' will become the officially supported EmberZNet driver in next release. If using Zigbee2MQTT see https://github.com/Koenkk/zigbee2mqtt/discussions/21462 [2024-08-11 12:32:49] error: zh:ezsp:uart: --> Error: Error: {"sequence":-1} after 10000ms
Tried adapter: ember instead
Error [2024-08-11 12:33:39] error: z2m: Error: Failed to start EZSP layer with status=HOST_FATAL_ERROR.

Any suggestions on what to try next would be most helpful.

I purchased the unit a while back and misplaced it before I had a chance to set it up, recently found it again and am trying to use it for a project at the school I work for.

stephack · August 12, 2024, 9:22pm

I have the tube-zb-gw-cc2652p2-poe and it would occasional need to be power cycled to get going. Not sure if it’s the HA x.8 update but it’s recently required me to power cycle a lot more than usual (3 times in the past week). In the past it would be a few months and I always assumed it might be because of UniFi updates.
@tube0013 any thoughts on the best way to troubleshoot this?

tube0013 · August 12, 2024, 9:36pm

Can you try and re flash the NCP firmware?

I have an addon that does this: https://github.com/tube0013/tubeszb_addons/blob/3d90a7fd46ccf60393c3ee1d42ffcfde70ca83c6/tzb-silabs-flasher/DOCS.md

For the NCP firmware link, use this: https://github.com/tube0013/tube_gateways/raw/main/models/current/tubeszb-efr32-MGM210-poe/firmware/efr32_MGM210/ncp/7.4.3/tubeszb-mgm21-2022_7.4.3.gbl

tube0013 · August 12, 2024, 9:39pm

I’d try a ESPhome build with static IP. you can use the new repo I created and described above to generate the binaries: Tube's ZB Coordinators and Routers (was Zigbee router on steroids?) - #1044 by tube0013

I’d recomend using the factory.bin (with <web.esphome.io> ) file and flashing over the micro usb port on the Olimex board. (you have to partially remove from the enclosure to access). This will erase the full flash to start “Fresh”

stephack · August 12, 2024, 10:20pm

@tube0013
I created the “issue” to generate the firmware.
When you say “start fresh”….am I losing any config or settings?

Also…can I use the OTA update option on the coordinators webui?

tube0013 · August 12, 2024, 10:34pm

The ESPHome side is just the local network connection and serial pass through. By flashing with the usb and using the factory.bi, I said “fresh” because it will completely erase the esp32 before flashing. This has known to be a fix for some issues from time time.

You can try the OTA method first and see if the device stabilizes, if not try the factory flash over usb. Or skip right to that…

tube0013 · August 12, 2024, 10:35pm

Also you can follow the firmware compilation by going to the Actions tab in the git hub repo

tube0013 · August 12, 2024, 11:09pm

Sorry for the delay… the firmware built, I had to update a few things in the repo, and also edit your original issue a tiny bit.

SpecialSchoolTech · August 12, 2024, 11:44pm

Thanks for your reply. I installed the add-on, followed the instructions you provided and configured with the following:

Network Device: 10.30.70.20:6638
Device: /dev/ttyS0
Flash USB Device: off
Firmware URL: (as provided in your reply)
Bootloader Baudrate: 115200
Hardware flow control: off
Verbose mode: on

The logs indicate it was unsuccessful.

I notice the unit has a micro-usb if I remove it from the case, can I connect to my PC and gather further information that way?

Your help is appreciated.

-----------------------------------------------------------
 Add-on: TubesZB Silicon Labs FW Flasher
 TubesZB Silicon Labs firmware flasher add-on
-----------------------------------------------------------
 Add-on version: 0.2.2
 You are running the latest version of this add-on.
 System: Home Assistant OS 12.4  (amd64 / qemux86-64)
 Home Assistant Core: 2024.8.1
 Home Assistant Supervisor: 2024.08.0
-----------------------------------------------------------
 Please, share the above information when looking for help
 or support in, e.g., GitHub, forums or the Discord chat.
-----------------------------------------------------------
s6-rc: info: service banner successfully started
s6-rc: info: service universal-silabs-flasher: starting
[09:11:02] INFO: Starting universal-silabs-flasher with socket://10.30.70.20:6638 (bootloader baudrate 115200)
2024-08-13 09:11:03 d0f5a498-tzb-silabs-flasher asyncio[154] DEBUG Using selector: EpollSelector
2024-08-13 09:11:03 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flash[154] INFO Extracted GBL metadata: NabuCasaMetadata(metadata_version=1, sdk_version='4.4.3', ezsp_version='7.4.2.0', ot_rcp_version=None, fw_type=<FirmwareImageType.NCP_UART_HW: 'ncp-uart-hw'>, baudrate=115200)
2024-08-13 09:11:03 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flash[154] DEBUG Probing app type ApplicationType.EZSP first
2024-08-13 09:11:03 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flash[154] DEBUG Probing with 115200 baudrate first
2024-08-13 09:11:03 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.GECKO_BOOTLOADER at 115200 baud
2024-08-13 09:11:03 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Connection made: <_SelectorSocketTransport fd=3 read=idle write=<idle, bufsize=0>>
2024-08-13 09:11:03 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'3'
2024-08-13 09:11:05 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.EZSP at 115200 baud
2024-08-13 09:11:06 d0f5a498-tzb-silabs-flasher bellows.ezsp[154] DEBUG Resetting EZSP
2024-08-13 09:11:06 d0f5a498-tzb-silabs-flasher bellows.uart[154] DEBUG Resetting ASH
2024-08-13 09:11:06 d0f5a498-tzb-silabs-flasher bellows.uart[154] DEBUG Sending: b'1ac038bc7e'
2024-08-13 09:11:11 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.CPC at 460800 baud
2024-08-13 09:11:11 d0f5a498-tzb-silabs-flasher bellows.uart[154] DEBUG Connection lost: None
2024-08-13 09:11:11 d0f5a498-tzb-silabs-flasher bellows.uart[154] DEBUG Closed serial connection
2024-08-13 09:11:11 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Connection made: <_SelectorSocketTransport fd=7 read=idle write=<idle, bufsize=0>>
2024-08-13 09:11:11 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:11 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:12 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 1 of 4)
2024-08-13 09:11:12 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:12 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:13 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 2 of 4)
2024-08-13 09:11:13 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:13 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:14 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 3 of 4)
2024-08-13 09:11:14 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:14 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:15 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 4 of 4)
2024-08-13 09:11:15 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.CPC at 115200 baud
2024-08-13 09:11:15 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Connection made: <_SelectorSocketTransport fd=3 read=idle write=<idle, bufsize=0>>
2024-08-13 09:11:15 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:15 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:16 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 1 of 4)
2024-08-13 09:11:16 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:16 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:17 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 2 of 4)
2024-08-13 09:11:17 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:17 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:18 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 3 of 4)
2024-08-13 09:11:18 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:18 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:19 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 4 of 4)
2024-08-13 09:11:19 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.CPC at 230400 baud
2024-08-13 09:11:19 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Connection made: <_SelectorSocketTransport fd=3 read=idle write=<idle, bufsize=0>>
2024-08-13 09:11:19 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:19 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:20 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 1 of 4)
2024-08-13 09:11:20 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:20 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:21 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 2 of 4)
2024-08-13 09:11:22 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:22 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:23 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 3 of 4)
2024-08-13 09:11:23 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 09:11:23 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 09:11:24 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 4 of 4)
2024-08-13 09:11:24 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.SPINEL at 460800 baud
2024-08-13 09:11:24 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Connection made: <_SelectorSocketTransport fd=3 read=idle write=<idle, bufsize=0>>
2024-08-13 09:11:24 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Sending frame SpinelFrame(header=SpinelHeader(transaction_id=3, network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02')
2024-08-13 09:11:24 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-08-13 09:11:25 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Failed to send SpinelFrame(header=SpinelHeader(network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02'), trying again in 0.10s (attempt 1 of 4)
2024-08-13 09:11:25 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Sending frame SpinelFrame(header=SpinelHeader(transaction_id=3, network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02')
2024-08-13 09:11:25 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-08-13 09:11:26 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Failed to send SpinelFrame(header=SpinelHeader(network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02'), trying again in 0.10s (attempt 2 of 4)
2024-08-13 09:11:26 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Sending frame SpinelFrame(header=SpinelHeader(transaction_id=3, network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02')
2024-08-13 09:11:26 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-08-13 09:11:27 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Failed to send SpinelFrame(header=SpinelHeader(network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02'), trying again in 0.10s (attempt 3 of 4)
2024-08-13 09:11:27 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Sending frame SpinelFrame(header=SpinelHeader(transaction_id=3, network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02')
2024-08-13 09:11:27 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-08-13 09:11:28 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Failed to send SpinelFrame(header=SpinelHeader(network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02'), trying again in 0.10s (attempt 4 of 4)
Error: Failed to probe running application type
[09:11:28] INFO: universal-silabs-flasher-up script exited with code 1
s6-rc: warning: unable to start service universal-silabs-flasher: command exited 1
s6-rc: info: service banner: stopping
/run/s6/basedir/scripts/rc.init: warning: s6-rc failed to properly bring all the services up! Check your logs (in /run/uncaught-logs/current if you have in-container logging) for more information.
/run/s6/basedir/scripts/rc.init: fatal: stopping the container.
s6-rc: info: service banner successfully stopped
s6-rc: info: service legacy-cont-init: stopping
s6-rc: info: service legacy-cont-init successfully stopped
s6-rc: info: service fix-attrs: stopping
s6-rc: info: service fix-attrs successfully stopped
s6-rc: info: service s6rc-oneshot-runner: stopping
s6-rc: info: service s6rc-oneshot-runner successfully stopped

tube0013 · August 13, 2024, 1:01am

Odd,

Try to manually put the efr32 into bootloader mode -in your browser go to http://ip_of_device

Switch on the bootloader pin, then hit the EFR32 Reset button.

Then try and start the addon again… in the web ui you should see the serial connection logged when the upgrade script tries to connect.

SpecialSchoolTech · August 13, 2024, 4:00am

Thanks for your help with this.

I have switched the Pull Bootloader pin (PA0) to Low option to On and state is showing ON.

The log shown in the web UI:

12:13:39	[D]	[switch:012] 'Pull Bootloader pin (PA0) to Low' Turning ON.
12:13:39	[D]	[switch:055] 'Pull Bootloader pin (PA0) to Low': Sending state ON
12:13:42	[D]	[button:010] 'EFR32 Reset' Pressed.
12:13:42	[D]	[switch:012] 'zRST_gpio' Turning ON.
12:13:42	[D]	[switch:012] 'zRST_gpio' Turning ON.
12:13:42	[D]	[switch:055] 'zRST_gpio': Sending state ON
12:13:42	[D]	[switch:016] 'zRST_gpio' Turning OFF.
12:13:42	[D]	[switch:055] 'zRST_gpio': Sending state OFF

Returning to Home Assistant, I have started the add-on again with no apparent change. Log is included at the bottom.

I have tried using telnet to 10.30.70.20:6638 then pulling the bootloader and resetting, received this. Entered 3 and it just showed the same menu again:

Gecko Bootloader v2.01.01
1. upload gbl
2. run
3. ebl info
BL > 3
Gecko Bootloader v2.01.01
1. upload gbl
2. run
3. ebl info
BL >

Add-on log:

-----------------------------------------------------------
 Add-on: TubesZB Silicon Labs FW Flasher
 TubesZB Silicon Labs firmware flasher add-on
-----------------------------------------------------------
 Add-on version: 0.2.2
 You are running the latest version of this add-on.
 System: Home Assistant OS 12.4  (amd64 / qemux86-64)
 Home Assistant Core: 2024.8.1
 Home Assistant Supervisor: 2024.08.0
-----------------------------------------------------------
 Please, share the above information when looking for help
 or support in, e.g., GitHub, forums or the Discord chat.
-----------------------------------------------------------
s6-rc: info: service banner successfully started
s6-rc: info: service universal-silabs-flasher: starting
[12:25:45] INFO: Starting universal-silabs-flasher with socket://10.30.70.20:6638 (bootloader baudrate 115200)
2024-08-13 12:25:46 d0f5a498-tzb-silabs-flasher asyncio[154] DEBUG Using selector: EpollSelector
2024-08-13 12:25:46 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flash[154] INFO Extracted GBL metadata: NabuCasaMetadata(metadata_version=1, sdk_version='4.4.3', ezsp_version='7.4.2.0', ot_rcp_version=None, fw_type=<FirmwareImageType.NCP_UART_HW: 'ncp-uart-hw'>, baudrate=115200)
2024-08-13 12:25:46 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flash[154] DEBUG Probing app type ApplicationType.EZSP first
2024-08-13 12:25:46 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flash[154] DEBUG Probing with 115200 baudrate first
2024-08-13 12:25:46 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.GECKO_BOOTLOADER at 115200 baud
2024-08-13 12:25:46 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Connection made: <_SelectorSocketTransport fd=3 read=idle write=<idle, bufsize=0>>
2024-08-13 12:25:46 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'3'
2024-08-13 12:25:48 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.EZSP at 115200 baud
2024-08-13 12:25:49 d0f5a498-tzb-silabs-flasher bellows.ezsp[154] DEBUG Resetting EZSP
2024-08-13 12:25:49 d0f5a498-tzb-silabs-flasher bellows.uart[154] DEBUG Resetting ASH
2024-08-13 12:25:49 d0f5a498-tzb-silabs-flasher bellows.uart[154] DEBUG Sending: b'1ac038bc7e'
2024-08-13 12:25:54 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.CPC at 460800 baud
2024-08-13 12:25:54 d0f5a498-tzb-silabs-flasher bellows.uart[154] DEBUG Connection lost: None
2024-08-13 12:25:54 d0f5a498-tzb-silabs-flasher bellows.uart[154] DEBUG Closed serial connection
2024-08-13 12:25:54 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Connection made: <_SelectorSocketTransport fd=7 read=idle write=<idle, bufsize=0>>
2024-08-13 12:25:54 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:25:54 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:25:55 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 1 of 4)
2024-08-13 12:25:55 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:25:55 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:25:56 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 2 of 4)
2024-08-13 12:25:56 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:25:56 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:25:57 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 3 of 4)
2024-08-13 12:25:57 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:25:57 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:25:58 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 4 of 4)
2024-08-13 12:25:58 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.CPC at 115200 baud
2024-08-13 12:25:58 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Connection made: <_SelectorSocketTransport fd=3 read=idle write=<idle, bufsize=0>>
2024-08-13 12:25:58 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:25:58 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:25:59 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 1 of 4)
2024-08-13 12:25:59 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:25:59 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:26:00 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 2 of 4)
2024-08-13 12:26:00 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:26:00 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:26:01 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 3 of 4)
2024-08-13 12:26:01 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:26:01 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:26:02 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 4 of 4)
2024-08-13 12:26:02 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.CPC at 230400 baud
2024-08-13 12:26:02 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Connection made: <_SelectorSocketTransport fd=3 read=idle write=<idle, bufsize=0>>
2024-08-13 12:26:02 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:26:02 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:26:03 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 1 of 4)
2024-08-13 12:26:04 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:26:04 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:26:05 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 2 of 4)
2024-08-13 12:26:05 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:26:05 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:26:06 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 3 of 4)
2024-08-13 12:26:06 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Sending frame CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b'')))
2024-08-13 12:26:06 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-08-13 12:26:07 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.cpc[154] DEBUG Failed to send CPCTransportFrame(endpoint=<EndpointId.SYSTEM: 0>, control=196, payload=UnnumberedFrame(command_id=<UnnumberedFrameCommandId.PROP_VALUE_GET: 2>, command_seq=0, payload=PropertyCommand(property_id=<PropertyId.SECONDARY_CPC_VERSION: 3>, value=b''))), trying again in 0.10s (attempt 4 of 4)
2024-08-13 12:26:07 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.flasher[154] INFO Probing ApplicationType.SPINEL at 460800 baud
2024-08-13 12:26:07 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Connection made: <_SelectorSocketTransport fd=3 read=idle write=<idle, bufsize=0>>
2024-08-13 12:26:07 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Sending frame SpinelFrame(header=SpinelHeader(transaction_id=3, network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02')
2024-08-13 12:26:07 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-08-13 12:26:08 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Failed to send SpinelFrame(header=SpinelHeader(network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02'), trying again in 0.10s (attempt 1 of 4)
2024-08-13 12:26:08 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Sending frame SpinelFrame(header=SpinelHeader(transaction_id=3, network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02')
2024-08-13 12:26:08 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-08-13 12:26:09 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Failed to send SpinelFrame(header=SpinelHeader(network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02'), trying again in 0.10s (attempt 2 of 4)
2024-08-13 12:26:09 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Sending frame SpinelFrame(header=SpinelHeader(transaction_id=3, network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02')
2024-08-13 12:26:09 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-08-13 12:26:10 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Failed to send SpinelFrame(header=SpinelHeader(network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02'), trying again in 0.10s (attempt 3 of 4)
2024-08-13 12:26:10 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Sending frame SpinelFrame(header=SpinelHeader(transaction_id=3, network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02')
2024-08-13 12:26:10 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.common[154] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-08-13 12:26:11 d0f5a498-tzb-silabs-flasher universal_silabs_flasher.spinel[154] DEBUG Failed to send SpinelFrame(header=SpinelHeader(network_link_id=0, flag=2), command_id=<CommandID.PROP_VALUE_GET: 2>, data=b'\x02'), trying again in 0.10s (attempt 4 of 4)
Error: Failed to probe running application type
[12:26:11] INFO: universal-silabs-flasher-up script exited with code 1
s6-rc: warning: unable to start service universal-silabs-flasher: command exited 1
s6-rc: info: service banner: stopping
/run/s6/basedir/scripts/rc.init: warning: s6-rc failed to properly bring all the services up! Check your logs (in /run/uncaught-logs/current if you have in-container logging) for more information.
/run/s6/basedir/scripts/rc.init: fatal: stopping the container.
s6-rc: info: service banner successfully stopped
s6-rc: info: service legacy-cont-init: stopping
s6-rc: info: service legacy-cont-init successfully stopped
s6-rc: info: service fix-attrs: stopping
s6-rc: info: service fix-attrs successfully stopped
s6-rc: info: service s6rc-oneshot-runner: stopping
s6-rc: info: service s6rc-oneshot-runner successfully stopped```

Shggy · August 14, 2024, 7:02pm

So I flashed the firmware via usb and today had the issue again. Below is an extract from the log which is showing the first instance of an error:

|[2024-08-14 19:27:51] debug: |zh:controller: Received payload: clusterID=61184, address=16831, groupID=0, endpoint=1, destinationEndpoint=1, wasBroadcast=false, linkQuality=149, frame={header:{frameControl:{frameType:1,manufacturerSpecific:false,direction:1,disableDefaultResponse:false,reservedBits:0},manufacturerCode:null,transactionSequenceNumber:81,commandIdentifier:2},payload:{seq:13312,dpValues:[{dp:104,datatype:2,data:{type:Buffer,data:[0,0,0,44]}}]},command:{ID:2,parameters:[{name:seq,type:33},{name:dpValues,type:1011}],name:dataReport}}|
|---|---|
|[2024-08-14 19:27:51] debug: |zh:zstack:unpi:parser: --- parseNext [254,33,68,129,0,0,0,239,229,55,1,1,0,61,0,104,38,190,0,0,13,9,12,2,0,82,109,2,0,4,0,0,0,0,104,251,28,168]|
|[2024-08-14 19:27:51] debug: |zh:zstack:unpi:parser: --> parsed 33 - 2 - 4 - 129 - [0,0,0,239,229,55,1,1,0,61,0,104,38,190,0,0,13,9,12,2,0,82,109,2,0,4,0,0,0,0,104,251,28] - 168|
|[2024-08-14 19:27:51] debug: |zh:zstack:znp: AREQ: <-- AF - incomingMsg - {groupid:0,clusterid:61184,srcaddr:14309,srcendpoint:1,dstendpoint:1,wasbroadcast:0,linkquality:61,securityuse:0,timestamp:12461672,transseqnumber:0,len:13,data:{type:Buffer,data:[9,12,2,0,82,109,2,0,4,0,0,0,0]}}|
|[2024-08-14 19:27:51] debug: |zh:controller: Data is from unknown device with address '14309', skipping...|
|[2024-08-14 19:27:51] debug: |zh:zstack:unpi:parser: --- parseNext []|
|[2024-08-14 19:27:51] debug: |z2m: Received Zigbee message from 'Living Room Presence Sensor 1', type 'commandDataReport', cluster 'manuSpecificTuya', data '{dpValues:[{data:{data:[0,0,0,44],type:Buffer},datatype:2,dp:104}],seq:13312}' from endpoint 1 with groupID 0|
|[2024-08-14 19:27:51] info: |z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/Living Room Presence Sensor 1', payload '{cli: ,detection_delay:0.1,fading_time:30,illuminance_lux:44,linkquality:149,maximum_range:4.5,minimum_range:1.05,presence:true,radar_sensitivity:6,self_test:check_success,target_distance:4}'|
|[2024-08-14 19:27:51] debug: |zh:zstack:unpi:parser: <-- [254,3,68,128,233,1,255,208]|
|[2024-08-14 19:27:51] debug: |zh:zstack:unpi:parser: --- parseNext [254,3,68,128,233,1,255,208]|
|[2024-08-14 19:27:51] debug: |zh:zstack:unpi:parser: --> parsed 3 - 2 - 4 - 128 - [233,1,255] - 208|
|[2024-08-14 19:27:51] debug: |zh:zstack:znp: AREQ: <-- AF - dataConfirm - {status:233,endpoint:1,transid:255}|
|[2024-08-14 19:27:51] debug: |zh:zstack:unpi:parser: --- parseNext []|
|[2024-08-14 19:27:51] debug: |zh:zstack: Data confirm error (0x70ac08fffe916aff:15203,233,0)|
|[2024-08-14 19:27:51] debug: |zh:zstack: Wait 2000ms|
|[2024-08-14 19:27:51] debug: |zh:zstack:unpi:parser: <-- [254,33,68,129,0,0,0,239,99,59,1,1,0,153,0,43,76,190,0,0,13,9,125,2,0,216,9,2,0,4,0,0,1,13,188,179,28,160]|
|[2024-08-14 19:27:51] debug: |zh:zstack:unpi:parser: --- parseNext [254,33,68,129,0,0,0,239,99,59,1,1,0,153,0,43,76,190,0,0,13,9,125,2,0,216,9,2,0,4,0,0,1,13,188,179,28,160]|
|[2024-08-14 19:27:51] debug: |zh:zstack:unpi:parser: --> parsed 33 - 2 - 4 - 129 - [0,0,0,239,99,59,1,1,0,153,0,43,76,190,0,0,13,9,125,2,0,216,9,2,0,4,0,0,1,13,188,179,28] - 160|
|[2024-08-14 19:27:51] debug: |zh:zstack:znp: AREQ: <-- AF - incomingMsg - |

Anything else to try?

tube0013 · August 14, 2024, 7:24pm

Okay, you will need to use the command line with https://github.com/NabuCasa/universal-silabs-flasher

download the gbl file from the firmware link to /config on your ha box.

if you install the Advanced SSH & Web Terminal add-on (Disable protection),

you can use wget to download the file:

cd /config

wget https://github.com/tube0013/tube_gateways/raw/main/models/current/tubeszb-efr32-MGM210-poe/firmware/efr32_MGM210/ncp/7.4.3/tubeszb-mgm21-2022_7.4.3.gbl

Then you can get into the home-assistant container where universal-silabs-flasher is already installed by doing:

docker exec -it homeassistant bash

then while the device is in the bootloader mode like you triggered, run:

universal-silabs-flasher -vv --device socket://IP:6638 --probe-method bootloader flash --force --firmware /config/tubeszb-mgm21-2022_7.4.3.gbl

That should hopefully flash the device.

tube0013 · August 14, 2024, 7:32pm

do you have any more logs, can you post to dpaste or something. I’m not seeing any disconnections there. I’m also not great with z2m logging.

Maybe you are experiencing one of the fw crashes that have prolonged the next release of the z-stack firmware. Maybe try the latest test FW from KoenKK:
https://github.com/Koenkk/Z-Stack-firmware/discussions/505

within the zip for the p7 use: CC1352P7_coordinator_20240710.hex