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…
Also you can follow the firmware compilation by going to the Actions tab in the git hub repo
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.
Thanks for your reply. I installed the add-on, followed the instructions you provided and configured with the following:
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
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.
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```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?
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.
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
Finally had time to push the f/w update today. I did it via usb as you recommended and everything seems to be functioning fine but I do see this in my Z2M logs. Let me know if we should be concerned. Thanks
Edit:
Restarted HA and restarting the Z2M add-on and the error did not reoccur.
[2024-08-18 10:00:21] error: zh:zstack:znp: Error while parsing to ZpiObject ‘Error: CommandID ‘159’ from subsystem ‘5’ not found
at Function.fromUnpiFrame (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/zpiObject.ts:66:19)
at Znp.onUnpiParsed (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:88:38)
at Parser.emit (node:events:517:28)
at Parser.parseNext (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:46:26)
at Parser._transform (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:20:14)
at Parser.Transform._write (node:internal/streams/transform:175:8)
at writeOrBuffer (node:internal/streams/writable:392:12)
at _write (node:internal/streams/writable:333:10)
at Parser.Writable.write (node:internal/streams/writable:337:10)
at Socket.ondata (node:internal/streams/readable:809:22)’
Also, the device info still says firmware 3.0 but with a different version of esp home. Expected? See below:
@tube0013 on a separate but related note. It looks like ESPHOME added a “breaking change” requirement to the config of esp devices that need to do ota updates. Specifying “platform” is now required in the ota section of the config. I wasn’t able to update any of my devices (not tube devices but my personal esp32’s) until I made this change today.
ota:
platform: esphome
I’ve updated the firmware, but now none of the devices in the network are connected through routers as seen on the network map, and most of my devices are offline.
Give it some time to come back up, if remains unstable try down grading fw, it’s my understanding though that this fw will be released next weekend.
It didn’t stabilise after a few hours. Downgrading the firmware didn’t help. I upgraded the firmware and took the opportunity to change the channel to 25 and started re-pairing things. Not everything had to be re-paired and it’s been back on line for 2 days.
Thanks for your reply. I have followed your instructions including putting it in bootloader mode, and it failed to probe running application type.
I then installed the universal-silabs-flasher on an Ubuntu system and ran the process again and it succeeded. It looks like there is some issue with communication from the HAOS system to the PoE unit. It is a standard HAOS install done only last month into a VM. The Ubuntu server is a VM on the same hypervisor. I can only assume all these issues are caused by some firewall rule on the HAOS server.
2024-08-22 12:55:36.789 homeassistant asyncio DEBUG Using selector: EpollSelector
2024-08-22 12:55:36.790 homeassistant universal_silabs_flasher.flash INFO Extracted GBL metadata: NabuCasaMetadata(metadata_version=1, sdk_version='4.4.3', ezsp_version='7.4.2.0', ot_rcp_version=None, cpc_version=None, fw_type=<FirmwareImageType.NCP_UART_HW: 'ncp-uart-hw'>, baudrate=115200)
2024-08-22 12:55:36.791 homeassistant universal_silabs_flasher.flash DEBUG Probing with 115200 baudrate first
2024-08-22 12:55:36.791 homeassistant universal_silabs_flasher.flasher INFO Probing ApplicationType.GECKO_BOOTLOADER at 115200 baud
2024-08-22 12:55:36.791 homeassistant zigpy.serial DEBUG Opening a serial connection to 'socket://10.30.70.20:6638' (baudrate=115200, xonxoff=False, rtscts=False)
2024-08-22 12:55:36.792 homeassistant universal_silabs_flasher.common DEBUG Connection made: <_SelectorSocketTransport fd=3 read=idle write=<idle, bufsize=0>>
2024-08-22 12:55:36.792 homeassistant universal_silabs_flasher.common DEBUG Sending data b'\n'
2024-08-22 12:55:36.793 homeassistant universal_silabs_flasher.common DEBUG Sending data b'3'
Error: Failed to probe running application type
Today I tried to update my mgm210-poe-2022 unit and faced exacly the same issue.
When I trying to use HA addon i see in logs:
-----------------------------------------------------------
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 13.0 (amd64 / qemux86-64)
Home Assistant Core: 2024.9.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
[15:06:00] INFO: Starting universal-silabs-flasher with socket://172.16.80.11:6638 (bootloader baudrate 115200)
Traceback (most recent call last):
File "/usr/local/bin/universal-silabs-flasher", line 5, in <module>
from universal_silabs_flasher.__main__ import main
File "/usr/local/lib/python3.11/site-packages/universal_silabs_flasher/__main__.py", line 1, in <module>
from .flash import main
File "/usr/local/lib/python3.11/site-packages/universal_silabs_flasher/flash.py", line 17, in <module>
import zigpy.ota.validators
File "/usr/local/lib/python3.11/site-packages/zigpy/ota/__init__.py", line 23, in <module>
import zigpy.ota.provider
File "/usr/local/lib/python3.11/site-packages/zigpy/ota/provider.py", line 17, in <module>
import aiohttp
File "/usr/local/lib/python3.11/site-packages/aiohttp/__init__.py", line 6, in <module>
from .client import (
File "/usr/local/lib/python3.11/site-packages/aiohttp/client.py", line 36, in <module>
from . import hdrs, http, payload
File "/usr/local/lib/python3.11/site-packages/aiohttp/http.py", line 1, in <module>
import http.server
File "<frozen importlib._bootstrap>", line 1176, in _find_and_load
File "<frozen importlib._bootstrap>", line 1147, in _find_and_load_unlocked
File "<frozen importlib._bootstrap>", line 690, in _load_unlocked
File "<frozen importlib._bootstrap_external>", line 936, in exec_module
File "<frozen importlib._bootstrap_external>", line 1069, in get_code
File "<frozen importlib._bootstrap_external>", line 729, in _compile_bytecode
ValueError: bad marshal data (unknown type code)
[15:06:00] 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
So I prepared vanilla Debian 12 with universal-silabs-flasher installed using pip:
root@flasher:~# /usr/local/bin/universal-silabs-flasher -vv --device socket://172.16.80.11:6638 --probe-method bootloader flash --force --firmware tubeszb-mgm21-2022_7.4.3.gbl
2024-09-09 13:15:20.150 flasher asyncio DEBUG Using selector: EpollSelector
2024-09-09 13:15:20.151 flasher universal_silabs_flasher.flash 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-09-09 13:15:20.151 flasher universal_silabs_flasher.flash DEBUG Probing with 115200 baudrate first
2024-09-09 13:15:20.151 flasher universal_silabs_flasher.flasher INFO Probing ApplicationType.GECKO_BOOTLOADER at 115200 baud
2024-09-09 13:15:20.151 flasher zigpy.serial DEBUG Opening a serial connection to 'socket://172.16.80.11:6638' (115200 baudrate)
2024-09-09 13:15:20.153 flasher universal_silabs_flasher.common DEBUG Connection made: <_SelectorSocketTransport fd=3 read=idle write=<idle, bufsize=0>>
2024-09-09 13:15:20.153 flasher universal_silabs_flasher.common DEBUG Sending data b'\n'
2024-09-09 13:15:20.154 flasher universal_silabs_flasher.common DEBUG Sending data b'3'
Error: Failed to probe running application type
Any tips how to jump from 7.4.2 to 7.4.3 version ?
Why don’t you update via the ESPHome addon? Updating via its WebUI is quite simple.
Thanks for advice.
Maybe I’m wrong, but I think you can’t upload zigbee firmware using esphome web interface. it should beused for esphome firmware upgrades only.
Correct the web front end is only used for ESPHome/ESP32 updates.
I went back and read your previous post again. When you get the bootloader via telnet, option 3 really doesn’t do anything for us here. if you enter 2, if their is a valid application on the EFR32 you will see a ~ if it starts. the 1 option is to upload a firmware file over telnet - you can use putty or another program to do this I believe.
you can also get the module in bootloader mode like you did and then use universal-silabs-flasher with the --probe-method bootloader option as I gave above.