Sonof Dongle ZBDongle-E kan niet upgraden naar Ember

[marque1968]

Ik heb de Sonof Zigbee 3.0 USB Dongle Plus gekocht (lees: kado gekregen voor mijn verjaardag) en wilde hem voor Home Assistant gebruiken. Het lukte me niet toen ik hem kocht, en heb het oude EZSP protocol nog maar even aangelaten.

Binnen Zigbee2MQTT krijg ik constant foutmeldingen


Dus dan toch maar een andere laptop regelen, waar het hopelijk wel mee lukt. Daar heb ik eerst gezorgd dat ik de juiste driver heb geïnstalleerd:


Daarna heb ik de upgrade vanaf de webpagina gestart. Eerst de stick aansluiten en dan op CONNECT drukken. Mijn stick wordt gevonden en ik start de verbinding. Hij start connecting, toont dat hij op een kwart is en daarna begint hij te spinnen.


Na een tijdje stopt het spinnen en krijg ik de foutmelding


Ik heb verschillende opties geprobeerd: Met de kabel en zonder de kabel, verschillende USB poorten. Zelfs een keer de nieuwe driver toch geprobeerd. Niets lukt.

Ik zou het nu niet meer weten wat ik nog meer kan doen om te upgraden. En ik moet iets doen, want 1 keer per dag gooit VirtualBox de USB poort weg en heb ik geen zigbee devices meer, en ik vermoed dat het aan die foutmeldingen met "Buffer out of bounds" kan liggen.

Oplossing

Voor degene die deze post in de toekomst lezen, het is opgelost!
Als je ditzelfde probleem hebt, moet je de dongle toch openschroeven. Je moet de (linker) bootknop van de dongle ingedrukt houden, als je inplugt, inclusief bij het indrukken van de connect knop. (nu ik erover nadenk, waarschijnlijk had ik het zelfs bij de connect bij de spinner nog vast, totdat hij het keuzescherm van de firmware gaf) Dan gaat hij wel door en kun je de juiste firmware selecteren en installeren.

[ Voor 10% gewijzigd door marque1968 op 23-05-2025 10:02 . Reden: Oplossing toegevoegd. ]

[marque1968]

Even losgehouden van de hoofd-post: Hierbij de debug log die ik krijg:

code:

2025-05-22 16:12:49 emscripten zigpy.serial[42] INFO Using pyserial-asyncio-fast in place of pyserial-asyncio
2025-05-22 16:12:51 emscripten zigpy.appdb[42] DEBUG SQLite version for <webserial_transport.MockSqlite3 object at 0x1222c00>: 3.31.1
2025-05-22 16:12:51 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.GECKO_BOOTLOADER at 115200 baud
2025-05-22 16:12:51 emscripten zigpy.serial[42] DEBUG Connection made: <webserial_transport.WebSerialTransport object at 0x1102b60>
2025-05-22 16:12:51 emscripten universal_silabs_flasher.gecko_bootloader[42] DEBUG Sending data b'\n'
2025-05-22 16:12:51 emscripten universal_silabs_flasher.gecko_bootloader[42] DEBUG Sending data GeckoBootloaderOption.EBL_INFO
2025-05-22 16:12:51 emscripten universal_silabs_flasher.gecko_bootloader[42] DEBUG Parsing State.WAITING_FOR_MENU: bytearray(b'\x11')
2025-05-22 16:12:52 emscripten universal_silabs_flasher.gecko_bootloader[42] DEBUG Parsing State.WAITING_FOR_MENU: bytearray(b'\x11\x1a')
2025-05-22 16:12:53 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:12:53 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:12:53 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:12:53 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:12:53 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.CPC at 460800 baud
2025-05-22 16:12:53 emscripten zigpy.serial[42] DEBUG Connection made: <webserial_transport.WebSerialTransport object at 0x16b46e8>
2025-05-22 16:12:53 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:12:53 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:12:54 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:12:54 emscripten universal_silabs_flasher.cpc[42] DEBUG Failed to parse buffer bytearray(b'x\x00\x80\xf8\x00x\x80\x00\x80\x00\xf8\xf8\x80\xf8\xf8x\xf8'): ValueError('Invalid flag')
2025-05-22 16:12:54 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:12:54 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:12:55 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:12:55 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:12:55 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:12:55 emscripten universal_silabs_flasher.cpc[42] DEBUG Failed to parse buffer bytearray(b'\x00\xf8\x00x\xf8xx\xf8\x80\x80\xf8'): ValueError('Invalid flag')
2025-05-22 16:12:56 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:12:56 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:12:56 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:12:57 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:12:57 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:12:57 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:12:57 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:12:57 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:12:57 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.CPC at 115200 baud
2025-05-22 16:12:58 emscripten zigpy.serial[42] DEBUG Connection made: <webserial_transport.WebSerialTransport object at 0x1fbaa80>
2025-05-22 16:12:58 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:12:58 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:12:59 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:12:59 emscripten universal_silabs_flasher.cpc[42] DEBUG Failed to parse buffer bytearray(b'\x11\x1a\xc1\x02\x02\x9b{~'): ValueError('Invalid flag')
2025-05-22 16:12:59 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:12:59 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:13:00 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:13:00 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:13:00 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:13:01 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:13:01 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:13:01 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:13:02 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:13:02 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:13:02 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:13:02 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:13:02 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:13:02 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.CPC at 230400 baud
2025-05-22 16:13:02 emscripten zigpy.serial[42] DEBUG Connection made: <webserial_transport.WebSerialTransport object at 0x1d7a240>
2025-05-22 16:13:02 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:13:02 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:13:03 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:13:03 emscripten universal_silabs_flasher.cpc[42] DEBUG Failed to parse buffer bytearray(b'\x06\xe0\x98\xe0\x06\x18\x18\x9e\xf8\x9e\x86\xfe'): ValueError('Invalid flag')
2025-05-22 16:13:03 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:13:03 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:13:04 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:13:04 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:13:04 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:13:05 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:13:05 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:13:05 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:13:06 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:13:06 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:13:06 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:13:06 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:13:06 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:13:06 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.EZSP at 115200 baud
2025-05-22 16:13:06 emscripten zigpy.serial[42] DEBUG Connection made: <bellows.ash.AshProtocol object at 0x1179558>
2025-05-22 16:13:06 emscripten bellows.ezsp[42] DEBUG Resetting EZSP
2025-05-22 16:13:06 emscripten bellows.uart[42] DEBUG Resetting ASH
2025-05-22 16:13:06 emscripten bellows.ash[42] DEBUG Sending frame CANCEL + RstFrame() + FLAG
2025-05-22 16:13:06 emscripten bellows.ash[42] DEBUG Sending data  1ac038bc7e
2025-05-22 16:13:06 emscripten bellows.ash[42] DEBUG Received data 11
2025-05-22 16:13:06 emscripten bellows.ash[42] DEBUG Received XON byte, resuming transmission
2025-05-22 16:13:07 emscripten bellows.ash[42] DEBUG Received data 1a
2025-05-22 16:13:07 emscripten bellows.ash[42] DEBUG Received cancel byte, clearing buffer
2025-05-22 16:13:07 emscripten bellows.ash[42] DEBUG Received data c102029b7b7e
2025-05-22 16:13:07 emscripten bellows.ash[42] DEBUG Received frame RStackFrame(version=2, reset_code=<NcpResetCode.RESET_POWER_ON: 2>)
2025-05-22 16:13:11 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:13:11 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:13:11 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:13:11 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:13:11 emscripten bellows.uart[42] DEBUG Connection lost: None
2025-05-22 16:13:11 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.EZSP at 230400 baud
2025-05-22 16:13:11 emscripten zigpy.serial[42] DEBUG Connection made: <bellows.ash.AshProtocol object at 0x20e6130>
2025-05-22 16:13:11 emscripten bellows.ezsp[42] DEBUG Resetting EZSP
2025-05-22 16:13:11 emscripten bellows.uart[42] DEBUG Resetting ASH
2025-05-22 16:13:11 emscripten bellows.ash[42] DEBUG Sending frame CANCEL + RstFrame() + FLAG
2025-05-22 16:13:11 emscripten bellows.ash[42] DEBUG Sending data  1ac038bc7e
2025-05-22 16:13:12 emscripten bellows.ash[42] DEBUG Received data 98
2025-05-22 16:13:12 emscripten bellows.ash[42] DEBUG Received data e00618189ef89e86fe
2025-05-22 16:13:12 emscripten bellows.ash[42] DEBUG Received substitute byte, marking buffer as corrupted
2025-05-22 16:13:16 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:13:16 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:13:16 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:13:16 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:13:16 emscripten bellows.uart[42] DEBUG Connection lost: None
2025-05-22 16:13:16 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.SPINEL at 460800 baud
2025-05-22 16:13:16 emscripten zigpy.serial[42] DEBUG Connection made: <webserial_transport.WebSerialTransport object at 0x20a1aa8>
2025-05-22 16:13:16 emscripten universal_silabs_flasher.spinel[42] 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')
2025-05-22 16:13:16 emscripten universal_silabs_flasher.spinel[42] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2025-05-22 16:13:17 emscripten universal_silabs_flasher.spinel[42] 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)
2025-05-22 16:13:18 emscripten universal_silabs_flasher.spinel[42] 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')
2025-05-22 16:13:18 emscripten universal_silabs_flasher.spinel[42] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2025-05-22 16:13:19 emscripten universal_silabs_flasher.spinel[42] 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)
2025-05-22 16:13:19 emscripten universal_silabs_flasher.spinel[42] 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')
2025-05-22 16:13:19 emscripten universal_silabs_flasher.spinel[42] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2025-05-22 16:13:20 emscripten universal_silabs_flasher.spinel[42] 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)
2025-05-22 16:13:20 emscripten universal_silabs_flasher.spinel[42] 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')
2025-05-22 16:13:20 emscripten universal_silabs_flasher.spinel[42] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2025-05-22 16:13:21 emscripten universal_silabs_flasher.spinel[42] 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)
2025-05-22 16:13:21 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:13:21 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:13:21 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:13:21 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:14:15 emscripten zigpy.serial[42] INFO Using pyserial-asyncio-fast in place of pyserial-asyncio
2025-05-22 16:14:17 emscripten zigpy.appdb[42] DEBUG SQLite version for <webserial_transport.MockSqlite3 object at 0x1214278>: 3.31.1
2025-05-22 16:14:17 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.GECKO_BOOTLOADER at 115200 baud
2025-05-22 16:14:17 emscripten zigpy.serial[42] DEBUG Connection made: <webserial_transport.WebSerialTransport object at 0x100c418>
2025-05-22 16:14:17 emscripten universal_silabs_flasher.gecko_bootloader[42] DEBUG Sending data b'\n'
2025-05-22 16:14:17 emscripten universal_silabs_flasher.gecko_bootloader[42] DEBUG Sending data GeckoBootloaderOption.EBL_INFO
2025-05-22 16:14:17 emscripten universal_silabs_flasher.gecko_bootloader[42] DEBUG Parsing State.WAITING_FOR_MENU: bytearray(b'\x11')
2025-05-22 16:14:18 emscripten universal_silabs_flasher.gecko_bootloader[42] DEBUG Parsing State.WAITING_FOR_MENU: bytearray(b'\x11\x1a')
2025-05-22 16:14:19 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:14:19 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:14:19 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:14:19 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:14:19 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.CPC at 460800 baud
2025-05-22 16:14:19 emscripten zigpy.serial[42] DEBUG Connection made: <webserial_transport.WebSerialTransport object at 0x2178a10>
2025-05-22 16:14:19 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:19 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:20 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:20 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:20 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:20 emscripten universal_silabs_flasher.cpc[42] DEBUG Failed to parse buffer bytearray(b'x\x00\x80\xf8\x00x\x80\x00\x80\x00\xf8\xf8\x80\xf8\xf8x\xf8'): ValueError('Invalid flag')
2025-05-22 16:14:21 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:21 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:21 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:22 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:22 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:22 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:23 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:23 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:14:23 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:14:23 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:14:23 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:14:23 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.CPC at 115200 baud
2025-05-22 16:14:23 emscripten zigpy.serial[42] DEBUG Connection made: <webserial_transport.WebSerialTransport object at 0x2172a08>
2025-05-22 16:14:23 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:23 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:24 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:24 emscripten universal_silabs_flasher.cpc[42] DEBUG Failed to parse buffer bytearray(b'\x11\x1a\xc1\x02\x02\x9b{~'): ValueError('Invalid flag')
2025-05-22 16:14:24 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:24 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:25 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:26 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:26 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:27 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:27 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:27 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:28 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:28 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:14:28 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:14:28 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:14:28 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:14:28 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.CPC at 230400 baud
2025-05-22 16:14:28 emscripten zigpy.serial[42] DEBUG Connection made: <webserial_transport.WebSerialTransport object at 0x2160dd8>
2025-05-22 16:14:28 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:28 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:29 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:29 emscripten universal_silabs_flasher.cpc[42] DEBUG Failed to parse buffer bytearray(b'\x06\xe0\x98\xe0\x06\x18\x18\x9e\xf8\x9e\x86\xfe'): ValueError('Invalid flag')
2025-05-22 16:14:29 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:29 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:30 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:30 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:30 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:31 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:31 emscripten universal_silabs_flasher.cpc[42] 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'')))
2025-05-22 16:14:31 emscripten universal_silabs_flasher.cpc[42] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2025-05-22 16:14:32 emscripten universal_silabs_flasher.cpc[42] 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)
2025-05-22 16:14:32 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:14:32 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:14:32 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:14:32 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:14:32 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.EZSP at 115200 baud
2025-05-22 16:14:32 emscripten zigpy.serial[42] DEBUG Connection made: <bellows.ash.AshProtocol object at 0x11b29c8>
2025-05-22 16:14:32 emscripten bellows.ezsp[42] DEBUG Resetting EZSP
2025-05-22 16:14:32 emscripten bellows.uart[42] DEBUG Resetting ASH
2025-05-22 16:14:32 emscripten bellows.ash[42] DEBUG Sending frame CANCEL + RstFrame() + FLAG
2025-05-22 16:14:32 emscripten bellows.ash[42] DEBUG Sending data  1ac038bc7e
2025-05-22 16:14:32 emscripten bellows.ash[42] DEBUG Received data 11
2025-05-22 16:14:32 emscripten bellows.ash[42] DEBUG Received XON byte, resuming transmission
2025-05-22 16:14:33 emscripten bellows.ash[42] DEBUG Received data 1a
2025-05-22 16:14:33 emscripten bellows.ash[42] DEBUG Received cancel byte, clearing buffer
2025-05-22 16:14:33 emscripten bellows.ash[42] DEBUG Received data c102029b7b7e
2025-05-22 16:14:33 emscripten bellows.ash[42] DEBUG Received frame RStackFrame(version=2, reset_code=<NcpResetCode.RESET_POWER_ON: 2>)
2025-05-22 16:14:37 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:14:37 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:14:37 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:14:37 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:14:37 emscripten bellows.uart[42] DEBUG Connection lost: None
2025-05-22 16:14:37 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.EZSP at 230400 baud
2025-05-22 16:14:37 emscripten zigpy.serial[42] DEBUG Connection made: <bellows.ash.AshProtocol object at 0x2014550>
2025-05-22 16:14:37 emscripten bellows.ezsp[42] DEBUG Resetting EZSP
2025-05-22 16:14:37 emscripten bellows.uart[42] DEBUG Resetting ASH
2025-05-22 16:14:37 emscripten bellows.ash[42] DEBUG Sending frame CANCEL + RstFrame() + FLAG
2025-05-22 16:14:37 emscripten bellows.ash[42] DEBUG Sending data  1ac038bc7e
2025-05-22 16:14:37 emscripten bellows.ash[42] DEBUG Received data 06
2025-05-22 16:14:37 emscripten bellows.ash[42] DEBUG Received data e0
2025-05-22 16:14:38 emscripten bellows.ash[42] DEBUG Received data 98
2025-05-22 16:14:38 emscripten bellows.ash[42] DEBUG Received data e00618189ef89e86fe
2025-05-22 16:14:38 emscripten bellows.ash[42] DEBUG Received substitute byte, marking buffer as corrupted
2025-05-22 16:14:42 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:14:42 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:14:42 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:14:42 emscripten zigpy.serial[42] DEBUG Connection lost: None
2025-05-22 16:14:42 emscripten bellows.uart[42] DEBUG Connection lost: None
2025-05-22 16:14:42 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.SPINEL at 460800 baud
2025-05-22 16:14:42 emscripten zigpy.serial[42] DEBUG Connection made: <webserial_transport.WebSerialTransport object at 0x1db3cb8>
2025-05-22 16:14:42 emscripten universal_silabs_flasher.spinel[42] 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')
2025-05-22 16:14:42 emscripten universal_silabs_flasher.spinel[42] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2025-05-22 16:14:43 emscripten universal_silabs_flasher.spinel[42] 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)
2025-05-22 16:14:43 emscripten universal_silabs_flasher.spinel[42] 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')
2025-05-22 16:14:43 emscripten universal_silabs_flasher.spinel[42] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2025-05-22 16:14:44 emscripten universal_silabs_flasher.spinel[42] 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)
2025-05-22 16:14:44 emscripten universal_silabs_flasher.spinel[42] 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')
2025-05-22 16:14:44 emscripten universal_silabs_flasher.spinel[42] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2025-05-22 16:14:45 emscripten universal_silabs_flasher.spinel[42] 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)
2025-05-22 16:14:46 emscripten universal_silabs_flasher.spinel[42] 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')
2025-05-22 16:14:46 emscripten universal_silabs_flasher.spinel[42] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2025-05-22 16:14:47 emscripten universal_silabs_flasher.spinel[42] 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)
2025-05-22 16:14:47 emscripten zigpy.serial[42] DEBUG Waiting for serial port to close
2025-05-22 16:14:47 emscripten webserial_transport[42] DEBUG Closing serial port
2025-05-22 16:14:47 emscripten webserial_transport[42] DEBUG Closed serial port
2025-05-22 16:14:47 emscripten zigpy.serial[42] DEBUG Connection lost: None

Wat me opvalt is dat hij eerst de verschillende baudrates afgaat en dan eindigt met:

code:

2025-05-22 16:14:32 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.EZSP at 115200 baud

Dit is wat ik ook zou verwachten, maar dan vlak voor het einde, als hij de retries ingaat, staat er

code:

2025-05-22 16:14:42 emscripten universal_silabs_flasher.flasher[42] INFO Probing ApplicationType.SPINEL at 460800 baud

Verbaast me, maar daar kan ik zelf niets aan veranderen. En ik zie heel wat filmpjes op youtube van mensen die het zonder problemen kunnen upgraden.

(ps: Ja, en ik weet dat hierna de stap komt dat ik het juiste gedownloade bestand moet opgeven, met in de naam de juiste baudrate, maar ik kom dus niet bij die stap uit)

[Septillion]

Je bent dus wel 100% zeker dat het de ZBDongle-E is?

Je zou ook nog de flasher van Sonoff zelf kunnen proberen.

[marque1968]

[Oon]

Maar je draait Home Assistant dus in VirtualBox?

Kun je niet beter gewoon een goedkope NUC gebruiken en daar HAOS op knallen? Bijv. v&a aangeboden: Intel NUC Kit NUC5CPYH

[marque1968]

Ik draai het mede in virtualbox omdat ik voorheen de deconz had, vanuit Domoticz, die ook los op die machine draaide (ook een NUC) plus een Thunderbird, die mijn mail alvast in verschillende folders verdeeld, voordat ik ze op mijn mobiel of laptop zie.

Maar toegegeven, ik zit te denken aan een thin client of een nuc te kopen waar HA native kan draaien. De huidige nuc wil ik dan Nextcloud op installeren en daar dan de HA backups laten uitkomen.


Dat gezegd hebbende, dat staat allemaal los van de wens om mijn Sonoff dongle te upgraden naar Amber.

[Ben(V)]

Heb je dit gelezen?
https://sonoff.tech/produ...-e-step-by-step-tutorial/

[Septillion]

@marque1968 Ik droeg twee punten aan hè

En op zich niets mis met HA OS als VM draaien.

[marque1968]

Ben(V) schreef op vrijdag 23 mei 2025 @ 08:18:
Heb je dit gelezen?
https://sonoff.tech/produ...-e-step-by-step-tutorial/

Nee, ik keek naar de Smart Home Junkie video omdat hiervoor geen openschroeven en resetknoppen nodig waren. Hierbij zouden de huidige devices gewoon gekoppeld blijven.

Maar, jouw opmerking is wel mijn oplossing geweest. Dank je wel. Omdat ik bovenstaande YouTube link zocht, ben ik even in de opmerkingen gegaan. En wat stond ertussen:


Dus toch de schroevendraaier gepakt, opengeschroefd en de (linker) boot-button ingedrukt gehouden terwijl ik de dongle aansluit en de connect-button indruk. Ik kies mijn dongle, spinner begint te draaien en..... HET WERKT! Ik kan de gedownloade firmware selecteren en de installatie werkt!


Het enige is dat daarna de connect knop toch weer niet werkt, maar ik heb de stick terug geplaatst in de HA server, de instelling aangepast dat hij naar Ember wijst, en de Zigbee2MQTT opnieuw opgestart. Alles werkt als verwacht, en ten tijde van dit schrijven nog geen error gezien.

Iedereen bedankt voor het meedenken. Iets waar ik al weken tegenaanloop kunnen oplossen door even met gelijkgestemden te kunnen praten.

[ Voor 4% gewijzigd door marque1968 op 23-05-2025 10:06 ]

[Ben(V)]

Volgens mij werkt die connect knop alleen als de Dongle in boot mode staat.

[marque1968]

Volgens Smart Home Junkie (en anderen) zou je het tegenwoordig kunnen updaten zonder te schroeven. Ook de reacties eronder geven aan dat dit voor hun de solution is. Sterker nog, onder de reactie die ik liet zien, dat je de knop moet indrukken, zegt hij ook dat hij dat niet eerder heeft gezien. Het lijkt op basis hiervan meer regel dat uitzondering

[Ben(V)]

Tja Sonoff zal het toch niet voor niets op hun website hebben staan in die link die ik gaf?

Maar ik weet dat er verschillende versies van die E dongle in omloop zijn.
Voor oudere versies heb je zelfs een andere driver nodig.

Zelf ben ik om niet tegen dit soort gezeur aan te lopen voor de P versie van de Dongle gegaan.
Die kan je altijd zonder open te schroeven updaten.

[ Voor 29% gewijzigd door Ben(V) op 23-05-2025 20:16 ]

[Septillion]

Ik gok een beetje dat dan de eerdere firmware dit gewoon niet ondersteunde (of misschien oudere hardware) Wel stom dat het dus een beetje vergeten lijkt, ook door Sonoff zelf...