Issues with Multiprotocol and SkyConnect

Hi,

i cannot get multi protocol running with the latest HA release.
When trying to flash SkyConnect, i get the error below.
Any ideas? ZHA etc. all broken.

s6-rc: info: service banner: starting
-----------------------------------------------------------
 Add-on: Silicon Labs Flasher
 Silicon Labs firmware flasher add-on
-----------------------------------------------------------
 Add-on version: 0.1.1
 You are running the latest version of this add-on.
 System: Home Assistant OS 10.3  (aarch64 / odroid-n2)
 Home Assistant Core: 2023.7.1
 Home Assistant Supervisor: 2023.07.1
-----------------------------------------------------------
 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
[14:31:53] INFO: Checking /dev/ttyUSB1 identifying SkyConnect v1.0 from Nabu Casa.
[14:31:53] INFO: Starting universal-silabs-flasher with /dev/ttyUSB1 (bootloader baudrate 115200)
2023-07-09 14:31:54 core-silabs-flasher asyncio[164] DEBUG Using selector: EpollSelector
2023-07-09 14:31:54 core-silabs-flasher universal_silabs_flasher.flash[164] INFO Extracted GBL metadata: NabuCasaMetadata(metadata_version=1, sdk_version='4.2.2', ezsp_version='7.2.2.0', ot_rcp_version=None, fw_type=<FirmwareImageType.NCP_UART_HW: 'ncp-uart-hw'>, baudrate=None)
2023-07-09 14:31:54 core-silabs-flasher universal_silabs_flasher.flash[164] DEBUG Probing app type ApplicationType.EZSP first
2023-07-09 14:31:54 core-silabs-flasher universal_silabs_flasher.flasher[164] INFO Probing ApplicationType.GECKO_BOOTLOADER at 115200 baud
2023-07-09 14:31:54 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <universal_silabs_flasher.gecko_bootloader.GeckoBootloaderProtocol object at 0xffff9c26fe80>, Serial<id=0xffff9c26fa90, open=True>(port='/dev/ttyUSB1', baudrate=115200, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2023-07-09 14:31:54 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'3'
2023-07-09 14:31:56 core-silabs-flasher universal_silabs_flasher.flasher[164] INFO Probing ApplicationType.EZSP at 115200 baud
2023-07-09 14:31:56 core-silabs-flasher bellows.ezsp[164] DEBUG Resetting EZSP
2023-07-09 14:31:56 core-silabs-flasher bellows.uart[164] DEBUG Resetting ASH
2023-07-09 14:31:56 core-silabs-flasher bellows.uart[164] DEBUG Sending: b'1ac038bc7e'
2023-07-09 14:32:01 core-silabs-flasher universal_silabs_flasher.flasher[164] INFO Probing ApplicationType.CPC at 460800 baud
2023-07-09 14:32:01 core-silabs-flasher bellows.uart[164] DEBUG Connection lost: None
2023-07-09 14:32:01 core-silabs-flasher bellows.uart[164] DEBUG Closed serial connection
2023-07-09 14:32:01 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <universal_silabs_flasher.cpc.CPCProtocol object at 0xffff9c2b8100>, Serial<id=0xffff9c2b82b0, open=True>(port='/dev/ttyUSB1', baudrate=460800, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2023-07-09 14:32:01 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:01 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:02 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:02 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:02 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:03 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:03 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:03 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:04 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:04 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:04 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:05 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:05 core-silabs-flasher universal_silabs_flasher.flasher[164] INFO Probing ApplicationType.CPC at 115200 baud
2023-07-09 14:32:05 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <universal_silabs_flasher.cpc.CPCProtocol object at 0xffff9c2b8610>, Serial<id=0xffff9c2b8100, open=True>(port='/dev/ttyUSB1', baudrate=115200, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2023-07-09 14:32:05 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:05 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:06 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:06 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:06 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:07 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:07 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:07 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:08 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:09 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:09 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:10 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:10 core-silabs-flasher universal_silabs_flasher.flasher[164] INFO Probing ApplicationType.CPC at 230400 baud
2023-07-09 14:32:10 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <universal_silabs_flasher.cpc.CPCProtocol object at 0xffff9c2b8580>, Serial<id=0xffff9c2b8610, open=True>(port='/dev/ttyUSB1', baudrate=230400, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2023-07-09 14:32:10 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:10 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:11 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:11 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:11 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:12 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:12 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:12 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:13 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:13 core-silabs-flasher universal_silabs_flasher.cpc[164] 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'')))
2023-07-09 14:32:13 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2023-07-09 14:32:14 core-silabs-flasher universal_silabs_flasher.cpc[164] 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)
2023-07-09 14:32:14 core-silabs-flasher universal_silabs_flasher.flasher[164] INFO Probing ApplicationType.SPINEL at 460800 baud
2023-07-09 14:32:14 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <universal_silabs_flasher.spinel.SpinelProtocol object at 0xffff9c2b8640>, Serial<id=0xffff9c2b8580, open=True>(port='/dev/ttyUSB1', baudrate=460800, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2023-07-09 14:32:14 core-silabs-flasher universal_silabs_flasher.spinel[164] 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')
2023-07-09 14:32:14 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2023-07-09 14:32:15 core-silabs-flasher universal_silabs_flasher.spinel[164] 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)
2023-07-09 14:32:15 core-silabs-flasher universal_silabs_flasher.spinel[164] 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')
2023-07-09 14:32:15 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2023-07-09 14:32:16 core-silabs-flasher universal_silabs_flasher.spinel[164] 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)
2023-07-09 14:32:16 core-silabs-flasher universal_silabs_flasher.spinel[164] 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')
2023-07-09 14:32:16 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2023-07-09 14:32:17 core-silabs-flasher universal_silabs_flasher.spinel[164] 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)
2023-07-09 14:32:17 core-silabs-flasher universal_silabs_flasher.spinel[164] 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')
2023-07-09 14:32:17 core-silabs-flasher universal_silabs_flasher.common[164] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2023-07-09 14:32:18 core-silabs-flasher universal_silabs_flasher.spinel[164] 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
[14:32:18] INFO: universal-silabs-flasher-up script exited with code 1
s6-rc: warning: unable to start service universal-silabs-flasher: command exited 1
/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: stopping
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
1 Like